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

• parent_buildername:publish_tarball
• user_agent:recipe

[13:41:17.189] New invocation is queued and will start shortly
[13:41:17.189] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[13:41:18.519] Starting the invocation (attempt 1)
[13:41:18.566] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:41:18.566] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:41:18.566] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9035512854650394016",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4254.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"be92ba31-908c-43c0-ada7-e522b85dd789\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4254.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9035512854650394016",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[13:41:19.115] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1599226878737984",
    "id": "8870082792360234592",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4254.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"be92ba31-908c-43c0-ada7-e522b85dd789\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4254.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1599226878953341",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035512854650394016",
      "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/8870082792360234592/+/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": "1599226878953588",
    "url": "https://ci.chromium.org/b/8870082792360234592",
    "utcnow_ts": "1599226879090887"
  }
}
[13:41:19.115] Task URL: https://ci.chromium.org/b/8870082792360234592
[13:41:19.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:2:0) after 1m0s
[13:42:15.656] Received PubSub notification, asking Buildbucket for the build status
[13:42:15.755] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:19.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:2:0)
[13:42:19.127] Timer tick, asking Buildbucket for the build status
[13:42:19.272] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:19.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:4:0) after 1m0s
[13:43:19.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:4:0)
[13:43:19.295] Timer tick, asking Buildbucket for the build status
[13:43:19.396] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:19.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:5:0) after 1m0s
[13:44:19.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:5:0)
[13:44:19.515] Timer tick, asking Buildbucket for the build status
[13:44:19.931] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:19.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:6:0) after 1m0s
[13:45:20.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:6:0)
[13:45:20.072] Timer tick, asking Buildbucket for the build status
[13:45:20.139] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:20.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:7:0) after 1m0s
[13:46:20.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:7:0)
[13:46:20.145] Timer tick, asking Buildbucket for the build status
[13:46:20.285] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:20.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:8:0) after 1m0s
[13:47:20.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:8:0)
[13:47:20.460] Timer tick, asking Buildbucket for the build status
[13:47:20.661] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:20.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:9:0) after 1m0s
[13:48:20.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:9:0)
[13:48:20.805] Timer tick, asking Buildbucket for the build status
[13:48:20.875] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:20.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:10:0) after 1m0s
[13:49:20.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:10:0)
[13:49:20.992] Timer tick, asking Buildbucket for the build status
[13:49:21.154] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:21.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:11:0) after 1m0s
[13:50:21.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:11:0)
[13:50:21.188] Timer tick, asking Buildbucket for the build status
[13:50:21.265] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:21.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:12:0) after 1m0s
[13:51:21.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:12:0)
[13:51:21.410] Timer tick, asking Buildbucket for the build status
[13:51:21.538] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:21.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:13:0) after 1m0s
[13:52:21.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:13:0)
[13:52:21.642] Timer tick, asking Buildbucket for the build status
[13:52:21.820] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:21.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:14:0) after 1m0s
[13:53:21.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:14:0)
[13:53:21.994] Timer tick, asking Buildbucket for the build status
[13:53:22.133] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:22.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:15:0) after 1m0s
[13:54:22.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:15:0)
[13:54:22.286] Timer tick, asking Buildbucket for the build status
[13:54:22.380] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:22.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:16:0) after 1m0s
[13:55:22.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:16:0)
[13:55:22.449] Timer tick, asking Buildbucket for the build status
[13:55:22.516] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:22.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:17:0) after 1m0s
[13:56:23.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:17:0)
[13:56:23.387] Timer tick, asking Buildbucket for the build status
[13:56:23.506] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:23.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:18:0) after 1m0s
[13:57:23.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:18:0)
[13:57:23.527] Timer tick, asking Buildbucket for the build status
[13:57:23.679] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:23.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:19:0) after 1m0s
[13:58:23.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:19:0)
[13:58:23.741] Timer tick, asking Buildbucket for the build status
[13:58:23.842] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:23.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:20:0) after 1m0s
[13:59:23.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:20:0)
[13:59:23.970] Timer tick, asking Buildbucket for the build status
[13:59:24.040] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:24.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:21:0) after 1m0s
[14:00:24.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:21:0)
[14:00:24.066] Timer tick, asking Buildbucket for the build status
[14:00:24.138] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:24.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:22:0) after 1m0s
[14:01:24.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:22:0)
[14:01:24.198] Timer tick, asking Buildbucket for the build status
[14:01:24.358] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:24.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:23:0) after 1m0s
[14:02:24.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:23:0)
[14:02:24.439] Timer tick, asking Buildbucket for the build status
[14:02:24.580] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:24.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:24:0) after 1m0s
[14:03:24.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:24:0)
[14:03:24.860] Timer tick, asking Buildbucket for the build status
[14:03:24.953] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:24.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:25:0) after 1m0s
[14:04:24.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:25:0)
[14:04:24.983] Timer tick, asking Buildbucket for the build status
[14:04:25.656] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:25.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:26:0) after 1m0s
[14:05:25.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:26:0)
[14:05:25.902] Timer tick, asking Buildbucket for the build status
[14:05:26.113] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:26.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:27:0) after 1m0s
[14:06:26.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:27:0)
[14:06:26.193] Timer tick, asking Buildbucket for the build status
[14:06:26.379] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:26.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:28:0) after 1m0s
[14:07:26.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:28:0)
[14:07:26.455] Timer tick, asking Buildbucket for the build status
[14:07:26.537] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:26.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:29:0) after 1m0s
[14:08:26.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:29:0)
[14:08:26.672] Timer tick, asking Buildbucket for the build status
[14:08:26.778] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:26.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:30:0) after 1m0s
[14:09:26.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:30:0)
[14:09:26.949] Timer tick, asking Buildbucket for the build status
[14:09:27.093] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:27.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:31:0) after 1m0s
[14:10:27.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:31:0)
[14:10:27.184] Timer tick, asking Buildbucket for the build status
[14:10:27.280] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:27.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:32:0) after 1m0s
[14:11:27.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:32:0)
[14:11:27.339] Timer tick, asking Buildbucket for the build status
[14:11:27.567] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:27.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:33:0) after 1m0s
[14:12:28.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:33:0)
[14:12:28.631] Timer tick, asking Buildbucket for the build status
[14:12:28.815] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:28.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:34:0) after 1m0s
[14:13:29.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:34:0)
[14:13:29.009] Timer tick, asking Buildbucket for the build status
[14:13:29.135] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:29.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:35:0) after 1m0s
[14:14:29.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:35:0)
[14:14:29.330] Timer tick, asking Buildbucket for the build status
[14:14:29.409] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:29.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:36:0) after 1m0s
[14:15:29.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:36:0)
[14:15:29.406] Timer tick, asking Buildbucket for the build status
[14:15:29.503] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:29.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:37:0) after 1m0s
[14:16:29.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:37:0)
[14:16:29.602] Timer tick, asking Buildbucket for the build status
[14:16:29.754] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:29.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:38:0) after 1m0s
[14:17:29.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:38:0)
[14:17:29.867] Timer tick, asking Buildbucket for the build status
[14:17:29.990] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:29.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:39:0) after 1m0s
[14:18:29.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:39:0)
[14:18:29.998] Timer tick, asking Buildbucket for the build status
[14:18:30.087] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:30.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:40:0) after 1m0s
[14:19:30.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:40:0)
[14:19:30.110] Timer tick, asking Buildbucket for the build status
[14:19:30.184] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:30.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:41:0) after 1m0s
[14:20:30.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:41:0)
[14:20:30.276] Timer tick, asking Buildbucket for the build status
[14:20:30.347] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:30.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:42:0) after 1m0s
[14:21:30.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:42:0)
[14:21:30.489] Timer tick, asking Buildbucket for the build status
[14:21:30.717] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:30.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:43:0) after 1m0s
[14:22:30.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:43:0)
[14:22:30.793] Timer tick, asking Buildbucket for the build status
[14:22:30.930] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:30.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:44:0) after 1m0s
[14:23:31.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:44:0)
[14:23:31.064] Timer tick, asking Buildbucket for the build status
[14:23:31.139] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:31.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:45:0) after 1m0s
[14:24:31.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:45:0)
[14:24:31.393] Timer tick, asking Buildbucket for the build status
[14:24:31.820] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:31.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:46:0) after 1m0s
[14:25:31.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:46:0)
[14:25:31.895] Timer tick, asking Buildbucket for the build status
[14:25:32.146] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:32.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:47:0) after 1m0s
[14:26:32.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:47:0)
[14:26:32.183] Timer tick, asking Buildbucket for the build status
[14:26:32.305] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:32.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:48:0) after 1m0s
[14:27:32.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:48:0)
[14:27:32.352] Timer tick, asking Buildbucket for the build status
[14:27:42.010] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:42.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:49:0) after 1m0s
[14:28:42.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:49:0)
[14:28:42.417] Timer tick, asking Buildbucket for the build status
[14:28:42.509] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:42.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:50:0) after 1m0s
[14:29:42.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:50:0)
[14:29:42.613] Timer tick, asking Buildbucket for the build status
[14:29:42.677] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:42.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:51:0) after 1m0s
[14:30:42.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:51:0)
[14:30:42.769] Timer tick, asking Buildbucket for the build status
[14:30:42.838] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:42.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:52:0) after 1m0s
[14:31:42.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:52:0)
[14:31:42.871] Timer tick, asking Buildbucket for the build status
[14:31:43.037] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:43.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:53:0) after 1m0s
[14:32:43.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:53:0)
[14:32:43.087] Timer tick, asking Buildbucket for the build status
[14:32:43.188] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:43.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:54:0) after 1m0s
[14:33:43.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:54:0)
[14:33:43.302] Timer tick, asking Buildbucket for the build status
[14:33:43.380] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:43.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:55:0) after 1m0s
[14:34:43.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:55:0)
[14:34:43.508] Timer tick, asking Buildbucket for the build status
[14:34:43.777] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:43.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:56:0) after 1m0s
[14:35:44.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:56:0)
[14:35:44.095] Timer tick, asking Buildbucket for the build status
[14:35:44.405] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:44.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:57:0) after 1m0s
[14:36:44.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:57:0)
[14:36:44.432] Timer tick, asking Buildbucket for the build status
[14:36:44.703] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:44.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:58:0) after 1m0s
[14:37:44.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:58:0)
[14:37:44.726] Timer tick, asking Buildbucket for the build status
[14:37:44.834] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:44.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:59:0) after 1m0s
[14:38:44.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:59:0)
[14:38:44.860] Timer tick, asking Buildbucket for the build status
[14:38:44.940] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:44.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:60:0) after 1m0s
[14:39:45.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:60:0)
[14:39:45.006] Timer tick, asking Buildbucket for the build status
[14:39:45.075] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:45.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:61:0) after 1m0s
[14:40:45.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:61:0)
[14:40:45.210] Timer tick, asking Buildbucket for the build status
[14:40:45.271] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:45.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:62:0) after 1m0s
[14:41:45.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:62:0)
[14:41:45.344] Timer tick, asking Buildbucket for the build status
[14:41:45.454] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:45.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:63:0) after 1m0s
[14:42:45.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:63:0)
[14:42:45.541] Timer tick, asking Buildbucket for the build status
[14:42:45.620] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:45.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:64:0) after 1m0s
[14:43:45.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:64:0)
[14:43:45.822] Timer tick, asking Buildbucket for the build status
[14:43:45.983] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:45.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:65:0) after 1m0s
[14:44:46.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:65:0)
[14:44:46.173] Timer tick, asking Buildbucket for the build status
[14:44:46.518] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:46.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:66:0) after 1m0s
[14:45:46.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:66:0)
[14:45:46.587] Timer tick, asking Buildbucket for the build status
[14:45:46.774] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:46.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:67:0) after 1m0s
[14:46:47.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:67:0)
[14:46:47.037] Timer tick, asking Buildbucket for the build status
[14:46:47.206] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:47.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:68:0) after 1m0s
[14:47:47.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:68:0)
[14:47:47.277] Timer tick, asking Buildbucket for the build status
[14:47:47.338] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:47.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:69:0) after 1m0s
[14:48:47.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:69:0)
[14:48:47.465] Timer tick, asking Buildbucket for the build status
[14:48:48.245] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:48.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:70:0) after 1m0s
[14:49:48.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:70:0)
[14:49:48.322] Timer tick, asking Buildbucket for the build status
[14:49:48.416] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:48.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:71:0) after 1m0s
[14:50:48.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:71:0)
[14:50:48.581] Timer tick, asking Buildbucket for the build status
[14:50:48.686] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:48.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:72:0) after 1m0s
[14:51:48.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:72:0)
[14:51:48.890] Timer tick, asking Buildbucket for the build status
[14:51:49.046] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:49.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:73:0) after 1m0s
[14:52:49.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:73:0)
[14:52:49.084] Timer tick, asking Buildbucket for the build status
[14:52:49.166] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:49.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:74:0) after 1m0s
[14:53:49.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:74:0)
[14:53:49.211] Timer tick, asking Buildbucket for the build status
[14:53:49.394] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:49.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:75:0) after 1m0s
[14:54:49.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:75:0)
[14:54:49.519] Timer tick, asking Buildbucket for the build status
[14:54:49.602] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:49.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:76:0) after 1m0s
[14:55:49.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:76:0)
[14:55:49.808] Timer tick, asking Buildbucket for the build status
[14:55:49.901] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:49.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:77:0) after 1m0s
[14:56:50.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:77:0)
[14:56:50.043] Timer tick, asking Buildbucket for the build status
[14:56:50.180] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:50.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:78:0) after 1m0s
[14:57:50.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:78:0)
[14:57:50.234] Timer tick, asking Buildbucket for the build status
[14:57:50.304] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:50.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:79:0) after 1m0s
[14:58:50.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:79:0)
[14:58:50.389] Timer tick, asking Buildbucket for the build status
[14:58:50.477] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:50.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:80:0) after 1m0s
[14:59:50.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:80:0)
[14:59:50.531] Timer tick, asking Buildbucket for the build status
[14:59:50.586] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:50.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:81:0) after 1m0s
[15:00:50.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:81:0)
[15:00:50.729] Timer tick, asking Buildbucket for the build status
[15:00:50.825] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:50.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:82:0) after 1m0s
[15:01:50.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:82:0)
[15:01:50.881] Timer tick, asking Buildbucket for the build status
[15:01:51.013] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:51.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:83:0) after 1m0s
[15:02:51.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:83:0)
[15:02:51.398] Timer tick, asking Buildbucket for the build status
[15:02:51.471] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:51.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:84:0) after 1m0s
[15:03:51.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:84:0)
[15:03:51.880] Timer tick, asking Buildbucket for the build status
[15:03:52.054] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:52.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:85:0) after 1m0s
[15:04:52.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:85:0)
[15:04:52.345] Timer tick, asking Buildbucket for the build status
[15:04:52.440] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:52.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:86:0) after 1m0s
[15:05:52.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:86:0)
[15:05:52.621] Timer tick, asking Buildbucket for the build status
[15:05:52.703] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:52.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:87:0) after 1m0s
[15:06:53.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:87:0)
[15:06:53.126] Timer tick, asking Buildbucket for the build status
[15:06:53.325] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:53.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:88:0) after 1m0s
[15:07:53.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:88:0)
[15:07:53.502] Timer tick, asking Buildbucket for the build status
[15:07:53.622] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:53.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:89:0) after 1m0s
[15:08:54.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:89:0)
[15:08:54.188] Timer tick, asking Buildbucket for the build status
[15:08:54.283] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:54.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:90:0) after 1m0s
[15:09:54.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:90:0)
[15:09:54.435] Timer tick, asking Buildbucket for the build status
[15:09:54.544] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:54.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:91:0) after 1m0s
[15:10:54.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:91:0)
[15:10:54.590] Timer tick, asking Buildbucket for the build status
[15:10:54.699] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:54.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:92:0) after 1m0s
[15:11:54.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:92:0)
[15:11:54.747] Timer tick, asking Buildbucket for the build status
[15:11:54.911] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:54.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:93:0) after 1m0s
[15:12:55.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:93:0)
[15:12:55.103] Timer tick, asking Buildbucket for the build status
[15:12:55.211] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:55.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:94:0) after 1m0s
[15:13:55.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:94:0)
[15:13:55.472] Timer tick, asking Buildbucket for the build status
[15:13:55.543] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:55.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:95:0) after 1m0s
[15:14:55.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:95:0)
[15:14:55.589] Timer tick, asking Buildbucket for the build status
[15:14:56.286] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:56.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:96:0) after 1m0s
[15:15:56.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:96:0)
[15:15:56.447] Timer tick, asking Buildbucket for the build status
[15:15:56.513] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:56.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:97:0) after 1m0s
[15:16:56.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:97:0)
[15:16:56.531] Timer tick, asking Buildbucket for the build status
[15:16:56.680] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:56.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:98:0) after 1m0s
[15:17:56.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:98:0)
[15:17:56.913] Timer tick, asking Buildbucket for the build status
[15:17:57.462] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:57.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:99:0) after 1m0s
[15:18:57.502] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:99:0)
[15:18:57.502] Timer tick, asking Buildbucket for the build status
[15:18:57.586] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:57.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:100:0) after 1m0s
[15:19:57.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:100:0)
[15:19:57.625] Timer tick, asking Buildbucket for the build status
[15:19:57.697] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:57.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:101:0) after 1m0s
[15:20:57.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:101:0)
[15:20:57.813] Timer tick, asking Buildbucket for the build status
[15:20:57.872] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:57.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:102:0) after 1m0s
[15:21:58.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:102:0)
[15:21:58.005] Timer tick, asking Buildbucket for the build status
[15:21:58.326] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:58.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:103:0) after 1m0s
[15:22:58.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:103:0)
[15:22:58.478] Timer tick, asking Buildbucket for the build status
[15:22:58.554] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:58.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:104:0) after 1m0s
[15:23:58.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:104:0)
[15:23:58.735] Timer tick, asking Buildbucket for the build status
[15:23:58.895] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:58.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:105:0) after 1m0s
[15:24:58.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:105:0)
[15:24:58.982] Timer tick, asking Buildbucket for the build status
[15:24:59.073] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:59.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:106:0) after 1m0s
[15:25:59.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:106:0)
[15:25:59.115] Timer tick, asking Buildbucket for the build status
[15:25:59.187] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:59.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:107:0) after 1m0s
[15:26:59.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:107:0)
[15:26:59.255] Timer tick, asking Buildbucket for the build status
[15:26:59.378] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:59.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:108:0) after 1m0s
[15:27:59.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:108:0)
[15:27:59.408] Timer tick, asking Buildbucket for the build status
[15:27:59.484] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:59.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:109:0) after 1m0s
[15:28:59.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:109:0)
[15:28:59.687] Timer tick, asking Buildbucket for the build status
[15:28:59.777] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:59.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:110:0) after 1m0s
[15:29:59.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:110:0)
[15:29:59.958] Timer tick, asking Buildbucket for the build status
[15:30:00.194] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:00.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:111:0) after 1m0s
[15:31:00.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:111:0)
[15:31:00.433] Timer tick, asking Buildbucket for the build status
[15:31:00.517] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:00.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:112:0) after 1m0s
[15:32:00.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:112:0)
[15:32:00.819] Timer tick, asking Buildbucket for the build status
[15:32:01.155] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:01.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:113:0) after 1m0s
[15:33:02.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:113:0)
[15:33:02.315] Timer tick, asking Buildbucket for the build status
[15:33:02.424] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:02.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:114:0) after 1m0s
[15:34:02.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:114:0)
[15:34:02.606] Timer tick, asking Buildbucket for the build status
[15:34:02.927] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:02.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:115:0) after 1m0s
[15:35:02.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:115:0)
[15:35:02.962] Timer tick, asking Buildbucket for the build status
[15:35:03.032] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:03.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:116:0) after 1m0s
[15:36:04.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:116:0)
[15:36:04.704] Timer tick, asking Buildbucket for the build status
[15:36:05.267] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:05.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:117:0) after 1m0s
[15:37:05.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:117:0)
[15:37:05.327] Timer tick, asking Buildbucket for the build status
[15:37:05.476] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:05.476] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:118:0) after 1m0s
[15:38:05.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:118:0)
[15:38:05.514] Timer tick, asking Buildbucket for the build status
[15:38:07.730] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:07.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:119:0) after 1m0s
[15:39:07.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:119:0)
[15:39:07.737] Timer tick, asking Buildbucket for the build status
[15:39:07.857] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:07.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:120:0) after 1m0s
[15:40:07.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:120:0)
[15:40:07.906] Timer tick, asking Buildbucket for the build status
[15:40:07.964] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:07.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:121:0) after 1m0s
[15:41:08.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:121:0)
[15:41:08.069] Timer tick, asking Buildbucket for the build status
[15:41:08.331] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:08.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:122:0) after 1m0s
[15:42:08.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:122:0)
[15:42:08.357] Timer tick, asking Buildbucket for the build status
[15:42:08.600] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:08.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:123:0) after 1m0s
[15:43:08.775] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:123:0)
[15:43:08.775] Timer tick, asking Buildbucket for the build status
[15:43:08.879] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:08.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:124:0) after 1m0s
[15:44:08.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:124:0)
[15:44:08.916] Timer tick, asking Buildbucket for the build status
[15:44:08.988] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:08.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:125:0) after 1m0s
[15:45:09.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:125:0)
[15:45:09.146] Timer tick, asking Buildbucket for the build status
[15:45:09.224] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:09.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:126:0) after 1m0s
[15:46:09.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:126:0)
[15:46:09.307] Timer tick, asking Buildbucket for the build status
[15:46:09.534] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:09.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:127:0) after 1m0s
[15:47:09.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:127:0)
[15:47:09.615] Timer tick, asking Buildbucket for the build status
[15:47:09.980] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:09.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:128:0) after 1m0s
[15:48:10.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:128:0)
[15:48:10.006] Timer tick, asking Buildbucket for the build status
[15:48:10.173] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:10.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:129:0) after 1m0s
[15:49:10.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:129:0)
[15:49:10.220] Timer tick, asking Buildbucket for the build status
[15:49:10.402] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:10.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:130:0) after 1m0s
[15:50:10.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:130:0)
[15:50:10.479] Timer tick, asking Buildbucket for the build status
[15:50:11.692] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:11.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:131:0) after 1m0s
[15:51:11.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:131:0)
[15:51:11.755] Timer tick, asking Buildbucket for the build status
[15:51:11.901] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:11.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:132:0) after 1m0s
[15:52:11.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:132:0)
[15:52:11.929] Timer tick, asking Buildbucket for the build status
[15:52:12.139] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:12.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:133:0) after 1m0s
[15:53:12.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:133:0)
[15:53:12.166] Timer tick, asking Buildbucket for the build status
[15:53:12.239] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:12.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:134:0) after 1m0s
[15:54:12.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:134:0)
[15:54:12.243] Timer tick, asking Buildbucket for the build status
[15:54:12.719] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:12.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:135:0) after 1m0s
[15:55:13.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:135:0)
[15:55:13.072] Timer tick, asking Buildbucket for the build status
[15:55:13.140] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:13.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:136:0) after 1m0s
[15:56:13.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:136:0)
[15:56:13.286] Timer tick, asking Buildbucket for the build status
[15:56:13.355] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:13.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:137:0) after 1m0s
[15:57:13.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:137:0)
[15:57:13.343] Timer tick, asking Buildbucket for the build status
[15:57:13.730] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:13.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:138:0) after 1m0s
[15:58:14.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:138:0)
[15:58:14.101] Timer tick, asking Buildbucket for the build status
[15:58:14.210] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:14.210] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:139:0) after 1m0s
[15:59:14.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:139:0)
[15:59:14.213] Timer tick, asking Buildbucket for the build status
[15:59:14.298] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:14.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:140:0) after 1m0s
[16:00:14.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:140:0)
[16:00:14.389] Timer tick, asking Buildbucket for the build status
[16:00:14.833] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:14.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:141:0) after 1m0s
[16:01:15.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:141:0)
[16:01:15.999] Timer tick, asking Buildbucket for the build status
[16:01:16.265] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:16.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:142:0) after 1m0s
[16:02:16.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:142:0)
[16:02:16.285] Timer tick, asking Buildbucket for the build status
[16:02:16.425] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:16.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:143:0) after 1m0s
[16:03:16.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:143:0)
[16:03:16.418] Timer tick, asking Buildbucket for the build status
[16:03:16.517] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:16.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:144:0) after 1m0s
[16:04:16.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:144:0)
[16:04:16.828] Timer tick, asking Buildbucket for the build status
[16:04:16.917] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:16.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:145:0) after 1m0s
[16:05:16.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:145:0)
[16:05:16.947] Timer tick, asking Buildbucket for the build status
[16:05:17.034] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:17.034] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:146:0) after 1m0s
[16:06:17.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:146:0)
[16:06:17.259] Timer tick, asking Buildbucket for the build status
[16:06:17.415] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:17.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:147:0) after 1m0s
[16:07:17.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:147:0)
[16:07:17.473] Timer tick, asking Buildbucket for the build status
[16:07:17.602] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:17.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:148:0) after 1m0s
[16:08:18.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:148:0)
[16:08:18.018] Timer tick, asking Buildbucket for the build status
[16:08:18.172] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:18.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:149:0) after 1m0s
[16:09:18.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:149:0)
[16:09:18.256] Timer tick, asking Buildbucket for the build status
[16:09:18.331] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:18.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:150:0) after 1m0s
[16:10:18.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:150:0)
[16:10:18.363] Timer tick, asking Buildbucket for the build status
[16:10:19.059] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:19.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:151:0) after 1m0s
[16:11:19.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:151:0)
[16:11:19.119] Timer tick, asking Buildbucket for the build status
[16:11:19.529] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:19.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:152:0) after 1m0s
[16:12:19.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:152:0)
[16:12:19.560] Timer tick, asking Buildbucket for the build status
[16:12:19.701] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:19.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:153:0) after 1m0s
[16:13:19.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:153:0)
[16:13:19.817] Timer tick, asking Buildbucket for the build status
[16:13:20.051] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:20.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:154:0) after 1m0s
[16:14:23.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:154:0)
[16:14:23.128] Timer tick, asking Buildbucket for the build status
[16:14:23.339] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:23.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:155:0) after 1m0s
[16:15:23.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:155:0)
[16:15:23.425] Timer tick, asking Buildbucket for the build status
[16:15:23.490] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:23.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:156:0) after 1m0s
[16:16:23.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:156:0)
[16:16:23.550] Timer tick, asking Buildbucket for the build status
[16:16:23.673] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:23.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:157:0) after 1m0s
[16:17:23.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:157:0)
[16:17:23.808] Timer tick, asking Buildbucket for the build status
[16:17:24.455] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:24.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:158:0) after 1m0s
[16:18:24.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:158:0)
[16:18:24.499] Timer tick, asking Buildbucket for the build status
[16:18:24.573] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:24.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:159:0) after 1m0s
[16:19:24.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:159:0)
[16:19:24.693] Timer tick, asking Buildbucket for the build status
[16:19:24.765] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:24.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:160:0) after 1m0s
[16:20:24.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:160:0)
[16:20:24.920] Timer tick, asking Buildbucket for the build status
[16:20:25.033] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:25.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:161:0) after 1m0s
[16:21:25.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:161:0)
[16:21:25.110] Timer tick, asking Buildbucket for the build status
[16:21:25.412] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:25.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:162:0) after 1m0s
[16:22:25.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:162:0)
[16:22:25.438] Timer tick, asking Buildbucket for the build status
[16:22:26.743] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:26.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:163:0) after 1m0s
[16:23:26.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:163:0)
[16:23:26.847] Timer tick, asking Buildbucket for the build status
[16:23:26.918] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:26.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:164:0) after 1m0s
[16:24:27.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:164:0)
[16:24:27.394] Timer tick, asking Buildbucket for the build status
[16:24:27.534] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:27.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:165:0) after 1m0s
[16:25:27.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:165:0)
[16:25:27.936] Timer tick, asking Buildbucket for the build status
[16:25:28.014] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:28.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:166:0) after 1m0s
[16:26:27.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:166:0)
[16:26:27.998] Timer tick, asking Buildbucket for the build status
[16:26:28.061] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:28.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:167:0) after 1m0s
[16:27:28.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:167:0)
[16:27:28.392] Timer tick, asking Buildbucket for the build status
[16:27:28.840] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:28.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:168:0) after 1m0s
[16:28:28.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:168:0)
[16:28:28.897] Timer tick, asking Buildbucket for the build status
[16:28:29.219] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:29.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:169:0) after 1m0s
[16:29:29.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:169:0)
[16:29:29.246] Timer tick, asking Buildbucket for the build status
[16:29:29.299] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:29.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:170:0) after 1m0s
[16:30:29.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:170:0)
[16:30:29.541] Timer tick, asking Buildbucket for the build status
[16:30:29.596] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:29.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:171:0) after 1m0s
[16:31:29.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:171:0)
[16:31:29.701] Timer tick, asking Buildbucket for the build status
[16:31:29.927] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:29.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:172:0) after 1m0s
[16:32:29.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:172:0)
[16:32:29.953] Timer tick, asking Buildbucket for the build status
[16:32:30.412] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:30.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:173:0) after 1m0s
[16:33:30.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:173:0)
[16:33:30.572] Timer tick, asking Buildbucket for the build status
[16:33:30.874] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:30.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:174:0) after 1m0s
[16:34:30.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:174:0)
[16:34:30.905] Timer tick, asking Buildbucket for the build status
[16:34:30.968] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:30.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:175:0) after 1m0s
[16:35:31.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:175:0)
[16:35:31.004] Timer tick, asking Buildbucket for the build status
[16:35:31.395] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:31.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:176:0) after 1m0s
[16:36:31.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:176:0)
[16:36:31.405] Timer tick, asking Buildbucket for the build status
[16:36:31.485] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:31.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:177:0) after 1m0s
[16:37:31.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:177:0)
[16:37:31.496] Timer tick, asking Buildbucket for the build status
[16:37:31.688] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:31.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:178:0) after 1m0s
[16:38:31.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:178:0)
[16:38:31.715] Timer tick, asking Buildbucket for the build status
[16:38:31.779] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:31.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:179:0) after 1m0s
[16:39:31.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:179:0)
[16:39:31.786] Timer tick, asking Buildbucket for the build status
[16:39:31.875] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:31.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:180:0) after 1m0s
[16:40:31.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:180:0)
[16:40:31.872] Timer tick, asking Buildbucket for the build status
[16:40:32.022] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:32.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:181:0) after 1m0s
[16:41:32.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:181:0)
[16:41:32.320] Timer tick, asking Buildbucket for the build status
[16:41:32.790] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:32.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:182:0) after 1m0s
[16:42:32.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:182:0)
[16:42:32.954] Timer tick, asking Buildbucket for the build status
[16:42:33.230] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:33.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:183:0) after 1m0s
[16:43:33.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:183:0)
[16:43:33.355] Timer tick, asking Buildbucket for the build status
[16:43:33.432] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:33.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:184:0) after 1m0s
[16:44:33.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:184:0)
[16:44:33.567] Timer tick, asking Buildbucket for the build status
[16:44:33.633] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:33.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:185:0) after 1m0s
[16:45:33.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:185:0)
[16:45:33.848] Timer tick, asking Buildbucket for the build status
[16:45:33.921] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:33.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:186:0) after 1m0s
[16:46:34.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:186:0)
[16:46:34.131] Timer tick, asking Buildbucket for the build status
[16:46:34.321] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:34.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:187:0) after 1m0s
[16:47:34.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:187:0)
[16:47:34.525] Timer tick, asking Buildbucket for the build status
[16:47:34.728] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:34.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:188:0) after 1m0s
[16:48:34.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:188:0)
[16:48:34.820] Timer tick, asking Buildbucket for the build status
[16:48:34.927] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:34.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:189:0) after 1m0s
[16:49:35.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:189:0)
[16:49:35.020] Timer tick, asking Buildbucket for the build status
[16:49:35.453] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:35.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:190:0) after 1m0s
[16:50:35.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:190:0)
[16:50:35.681] Timer tick, asking Buildbucket for the build status
[16:50:35.784] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:35.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:191:0) after 1m0s
[16:51:36.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:191:0)
[16:51:36.097] Timer tick, asking Buildbucket for the build status
[16:51:36.285] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:36.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:192:0) after 1m0s
[16:52:36.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:192:0)
[16:52:36.368] Timer tick, asking Buildbucket for the build status
[16:52:36.489] Build 8870082792360234592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:36.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9035512854650394016:193:0) after 1m0s
[16:53:07.913] Received PubSub notification, asking Buildbucket for the build status
[16:53:08.346] Build 8870082792360234592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:53:08.346] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1599238387017960",
    "created_by": "project:infra",
    "created_ts": "1599226878737984",
    "id": "8870082792360234592",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4254.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"be92ba31-908c-43c0-ada7-e522b85dd789\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4254.2\"}}",
    "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-z8g7\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5507-6e8d655\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1599226934669968",
    "status": "COMPLETED",
    "status_changed_ts": "1599238387485048",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9035512854650394016",
      "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/8870082792360234592/+/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:4e722b24e38c7510",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1599238387521057",
    "url": "https://ci.chromium.org/b/8870082792360234592",
    "utcnow_ts": "1599238388305649"
  }
}
[16:53:08.346] Invocation finished in 3h11m51.177019884s with status SUCCEEDED