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

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

{
  "version": "86.0.4222.4"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[23:04:38.721] New invocation is queued and will start shortly
[23:04:38.721] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:04:39.834] Starting the invocation (attempt 1)
[23:04:39.873] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:04:39.873] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:04:39.873] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038195320165835168",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4222.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"0020d555-0570-407f-96ad-6ef902da5da4\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4222.4\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9038195320165835168",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[23:04:40.672] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596668680045819",
    "id": "8872765258111466944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4222.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0020d555-0570-407f-96ad-6ef902da5da4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4222.4\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596668680399912",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038195320165835168",
      "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/8872765258111466944/+/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": "1596668680400057",
    "url": "https://ci.chromium.org/b/8872765258111466944",
    "utcnow_ts": "1596668680651446"
  }
}
[23:04:40.672] Task URL: https://ci.chromium.org/b/8872765258111466944
[23:04:40.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:2:0) after 1m0s
[23:05:24.183] Received PubSub notification, asking Buildbucket for the build status
[23:05:24.263] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:40.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:2:0)
[23:05:40.745] Timer tick, asking Buildbucket for the build status
[23:05:41.393] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:41.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:4:0) after 1m0s
[23:06:41.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:4:0)
[23:06:41.485] Timer tick, asking Buildbucket for the build status
[23:06:41.618] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:41.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:5:0) after 1m0s
[23:07:41.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:5:0)
[23:07:41.697] Timer tick, asking Buildbucket for the build status
[23:07:42.019] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:42.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:6:0) after 1m0s
[23:08:42.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:6:0)
[23:08:42.038] Timer tick, asking Buildbucket for the build status
[23:08:42.196] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:42.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:7:0) after 1m0s
[23:09:42.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:7:0)
[23:09:42.337] Timer tick, asking Buildbucket for the build status
[23:09:42.444] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:42.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:8:0) after 1m0s
[23:10:42.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:8:0)
[23:10:42.471] Timer tick, asking Buildbucket for the build status
[23:10:42.591] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:42.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:9:0) after 1m0s
[23:11:42.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:9:0)
[23:11:42.649] Timer tick, asking Buildbucket for the build status
[23:11:42.789] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:42.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:10:0) after 1m0s
[23:12:42.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:10:0)
[23:12:42.868] Timer tick, asking Buildbucket for the build status
[23:12:42.946] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:42.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:11:0) after 1m0s
[23:13:43.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:11:0)
[23:13:43.086] Timer tick, asking Buildbucket for the build status
[23:13:43.161] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:43.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:12:0) after 1m0s
[23:14:43.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:12:0)
[23:14:43.315] Timer tick, asking Buildbucket for the build status
[23:14:43.389] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:43.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:13:0) after 1m0s
[23:15:43.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:13:0)
[23:15:43.494] Timer tick, asking Buildbucket for the build status
[23:15:43.617] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:43.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:14:0) after 1m0s
[23:16:43.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:14:0)
[23:16:43.652] Timer tick, asking Buildbucket for the build status
[23:16:43.753] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:43.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:15:0) after 1m0s
[23:17:43.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:15:0)
[23:17:43.840] Timer tick, asking Buildbucket for the build status
[23:17:44.312] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:44.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:16:0) after 1m0s
[23:18:44.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:16:0)
[23:18:44.419] Timer tick, asking Buildbucket for the build status
[23:18:44.609] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:44.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:17:0) after 1m0s
[23:19:44.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:17:0)
[23:19:44.695] Timer tick, asking Buildbucket for the build status
[23:19:44.786] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:44.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:18:0) after 1m0s
[23:20:44.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:18:0)
[23:20:44.863] Timer tick, asking Buildbucket for the build status
[23:20:45.004] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:45.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:19:0) after 1m0s
[23:21:45.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:19:0)
[23:21:45.069] Timer tick, asking Buildbucket for the build status
[23:21:45.159] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:45.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:20:0) after 1m0s
[23:22:45.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:20:0)
[23:22:45.258] Timer tick, asking Buildbucket for the build status
[23:22:45.356] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:45.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:21:0) after 1m0s
[23:23:45.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:21:0)
[23:23:45.445] Timer tick, asking Buildbucket for the build status
[23:23:45.739] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:45.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:22:0) after 1m0s
[23:24:45.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:22:0)
[23:24:45.758] Timer tick, asking Buildbucket for the build status
[23:24:45.856] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:45.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:23:0) after 1m0s
[23:25:46.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:23:0)
[23:25:46.124] Timer tick, asking Buildbucket for the build status
[23:25:46.266] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:46.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:24:0) after 1m0s
[23:26:46.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:24:0)
[23:26:46.413] Timer tick, asking Buildbucket for the build status
[23:26:46.534] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:46.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:25:0) after 1m0s
[23:27:46.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:25:0)
[23:27:46.628] Timer tick, asking Buildbucket for the build status
[23:27:46.900] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:46.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:26:0) after 1m0s
[23:28:47.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:26:0)
[23:28:47.061] Timer tick, asking Buildbucket for the build status
[23:28:47.134] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:47.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:27:0) after 1m0s
[23:29:47.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:27:0)
[23:29:47.258] Timer tick, asking Buildbucket for the build status
[23:29:47.322] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:47.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:28:0) after 1m0s
[23:30:47.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:28:0)
[23:30:47.541] Timer tick, asking Buildbucket for the build status
[23:30:48.003] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:48.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:29:0) after 1m0s
[23:31:48.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:29:0)
[23:31:48.046] Timer tick, asking Buildbucket for the build status
[23:31:48.151] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:48.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:30:0) after 1m0s
[23:32:48.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:30:0)
[23:32:48.184] Timer tick, asking Buildbucket for the build status
[23:32:48.250] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:48.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:31:0) after 1m0s
[23:33:48.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:31:0)
[23:33:48.348] Timer tick, asking Buildbucket for the build status
[23:33:48.517] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:48.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:32:0) after 1m0s
[23:34:48.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:32:0)
[23:34:48.537] Timer tick, asking Buildbucket for the build status
[23:34:48.609] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:48.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:33:0) after 1m0s
[23:35:48.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:33:0)
[23:35:48.660] Timer tick, asking Buildbucket for the build status
[23:35:48.899] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:48.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:34:0) after 1m0s
[23:36:49.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:34:0)
[23:36:49.225] Timer tick, asking Buildbucket for the build status
[23:36:49.347] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:49.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:35:0) after 1m0s
[23:37:49.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:35:0)
[23:37:49.476] Timer tick, asking Buildbucket for the build status
[23:37:49.550] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:49.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:36:0) after 1m0s
[23:38:49.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:36:0)
[23:38:49.687] Timer tick, asking Buildbucket for the build status
[23:38:49.766] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:49.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:37:0) after 1m0s
[23:39:49.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:37:0)
[23:39:49.956] Timer tick, asking Buildbucket for the build status
[23:39:50.176] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:50.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:38:0) after 1m0s
[23:40:50.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:38:0)
[23:40:50.274] Timer tick, asking Buildbucket for the build status
[23:40:50.472] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:50.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:39:0) after 1m0s
[23:41:50.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:39:0)
[23:41:50.561] Timer tick, asking Buildbucket for the build status
[23:41:50.630] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:50.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:40:0) after 1m0s
[23:42:50.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:40:0)
[23:42:50.813] Timer tick, asking Buildbucket for the build status
[23:42:51.209] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:51.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:41:0) after 1m0s
[23:43:51.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:41:0)
[23:43:51.298] Timer tick, asking Buildbucket for the build status
[23:43:51.366] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:51.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:42:0) after 1m0s
[23:44:51.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:42:0)
[23:44:51.449] Timer tick, asking Buildbucket for the build status
[23:44:51.543] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:51.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:43:0) after 1m0s
[23:45:51.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:43:0)
[23:45:51.628] Timer tick, asking Buildbucket for the build status
[23:45:51.747] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:51.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:44:0) after 1m0s
[23:46:52.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:44:0)
[23:46:52.009] Timer tick, asking Buildbucket for the build status
[23:46:52.288] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:52.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:45:0) after 1m0s
[23:47:52.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:45:0)
[23:47:52.511] Timer tick, asking Buildbucket for the build status
[23:47:52.573] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:52.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:46:0) after 1m0s
[23:48:53.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:46:0)
[23:48:53.176] Timer tick, asking Buildbucket for the build status
[23:48:53.253] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:53.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:47:0) after 1m0s
[23:49:53.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:47:0)
[23:49:53.528] Timer tick, asking Buildbucket for the build status
[23:49:53.610] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:53.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:48:0) after 1m0s
[23:50:53.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:48:0)
[23:50:53.715] Timer tick, asking Buildbucket for the build status
[23:50:54.270] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:54.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:49:0) after 1m0s
[23:51:54.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:49:0)
[23:51:54.505] Timer tick, asking Buildbucket for the build status
[23:51:54.577] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:54.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:50:0) after 1m0s
[23:52:54.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:50:0)
[23:52:54.696] Timer tick, asking Buildbucket for the build status
[23:52:54.924] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:54.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:51:0) after 1m0s
[23:53:54.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:51:0)
[23:53:54.991] Timer tick, asking Buildbucket for the build status
[23:53:55.136] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:55.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:52:0) after 1m0s
[23:54:55.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:52:0)
[23:54:55.182] Timer tick, asking Buildbucket for the build status
[23:54:55.278] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:55.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:53:0) after 1m0s
[23:55:55.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:53:0)
[23:55:55.334] Timer tick, asking Buildbucket for the build status
[23:55:55.804] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:55.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:54:0) after 1m0s
[23:56:55.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:54:0)
[23:56:55.795] Timer tick, asking Buildbucket for the build status
[23:56:55.913] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:55.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:55:0) after 1m0s
[23:57:55.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:55:0)
[23:57:55.970] Timer tick, asking Buildbucket for the build status
[23:57:56.121] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:56.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:56:0) after 1m0s
[23:58:56.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:56:0)
[23:58:56.188] Timer tick, asking Buildbucket for the build status
[23:58:56.256] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:56.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:57:0) after 1m0s
[23:59:56.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:57:0)
[23:59:56.376] Timer tick, asking Buildbucket for the build status
[23:59:56.578] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:56.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:58:0) after 1m0s
[00:00:56.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:58:0)
[00:00:56.709] Timer tick, asking Buildbucket for the build status
[00:00:57.155] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:57.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:59:0) after 1m0s
[00:01:57.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:59:0)
[00:01:57.236] Timer tick, asking Buildbucket for the build status
[00:01:57.308] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:57.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:60:0) after 1m0s
[00:02:57.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:60:0)
[00:02:57.362] Timer tick, asking Buildbucket for the build status
[00:02:57.420] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:57.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:61:0) after 1m0s
[00:03:57.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:61:0)
[00:03:57.473] Timer tick, asking Buildbucket for the build status
[00:03:57.751] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:57.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:62:0) after 1m0s
[00:04:57.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:62:0)
[00:04:57.851] Timer tick, asking Buildbucket for the build status
[00:04:58.044] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:58.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:63:0) after 1m0s
[00:05:58.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:63:0)
[00:05:58.145] Timer tick, asking Buildbucket for the build status
[00:05:58.688] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:58.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:64:0) after 1m0s
[00:06:58.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:64:0)
[00:06:58.718] Timer tick, asking Buildbucket for the build status
[00:06:58.836] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:58.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:65:0) after 1m0s
[00:07:58.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:65:0)
[00:07:58.894] Timer tick, asking Buildbucket for the build status
[00:07:59.104] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:59.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:66:0) after 1m0s
[00:08:59.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:66:0)
[00:08:59.207] Timer tick, asking Buildbucket for the build status
[00:08:59.265] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:59.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:67:0) after 1m0s
[00:09:59.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:67:0)
[00:09:59.326] Timer tick, asking Buildbucket for the build status
[00:09:59.424] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:59.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:68:0) after 1m0s
[00:10:59.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:68:0)
[00:10:59.613] Timer tick, asking Buildbucket for the build status
[00:11:02.603] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:02.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:69:0) after 1m0s
[00:12:02.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:69:0)
[00:12:02.637] Timer tick, asking Buildbucket for the build status
[00:12:02.803] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:02.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:70:0) after 1m0s
[00:13:02.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:70:0)
[00:13:02.846] Timer tick, asking Buildbucket for the build status
[00:13:02.911] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:02.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:71:0) after 1m0s
[00:14:03.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:71:0)
[00:14:03.135] Timer tick, asking Buildbucket for the build status
[00:14:03.806] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:03.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:72:0) after 1m0s
[00:15:04.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:72:0)
[00:15:04.004] Timer tick, asking Buildbucket for the build status
[00:15:04.466] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:04.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:73:0) after 1m0s
[00:16:04.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:73:0)
[00:16:04.581] Timer tick, asking Buildbucket for the build status
[00:16:04.670] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:04.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:74:0) after 1m0s
[00:17:04.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:74:0)
[00:17:04.891] Timer tick, asking Buildbucket for the build status
[00:17:04.964] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:04.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:75:0) after 1m0s
[00:18:05.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:75:0)
[00:18:05.092] Timer tick, asking Buildbucket for the build status
[00:18:05.183] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:05.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:76:0) after 1m0s
[00:19:05.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:76:0)
[00:19:05.254] Timer tick, asking Buildbucket for the build status
[00:19:05.347] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:05.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:77:0) after 1m0s
[00:20:05.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:77:0)
[00:20:05.421] Timer tick, asking Buildbucket for the build status
[00:20:05.597] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:05.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:78:0) after 1m0s
[00:21:05.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:78:0)
[00:21:05.617] Timer tick, asking Buildbucket for the build status
[00:21:05.799] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:05.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:79:0) after 1m0s
[00:22:05.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:79:0)
[00:22:05.903] Timer tick, asking Buildbucket for the build status
[00:22:06.054] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:06.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:80:0) after 1m0s
[00:23:06.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:80:0)
[00:23:06.117] Timer tick, asking Buildbucket for the build status
[00:23:06.217] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:06.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:81:0) after 1m0s
[00:24:06.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:81:0)
[00:24:06.303] Timer tick, asking Buildbucket for the build status
[00:24:06.398] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:06.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:82:0) after 1m0s
[00:25:06.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:82:0)
[00:25:06.393] Timer tick, asking Buildbucket for the build status
[00:25:06.640] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:06.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:83:0) after 1m0s
[00:26:06.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:83:0)
[00:26:06.893] Timer tick, asking Buildbucket for the build status
[00:26:07.042] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:07.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:84:0) after 1m0s
[00:27:07.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:84:0)
[00:27:07.176] Timer tick, asking Buildbucket for the build status
[00:27:07.264] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:07.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:85:0) after 1m0s
[00:28:07.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:85:0)
[00:28:07.539] Timer tick, asking Buildbucket for the build status
[00:28:07.601] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:07.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:86:0) after 1m0s
[00:29:07.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:86:0)
[00:29:07.670] Timer tick, asking Buildbucket for the build status
[00:29:07.795] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:07.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:87:0) after 1m0s
[00:30:07.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:87:0)
[00:30:07.823] Timer tick, asking Buildbucket for the build status
[00:30:08.062] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:08.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:88:0) after 1m0s
[00:31:08.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:88:0)
[00:31:08.384] Timer tick, asking Buildbucket for the build status
[00:31:08.457] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:08.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:89:0) after 1m0s
[00:32:08.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:89:0)
[00:32:08.600] Timer tick, asking Buildbucket for the build status
[00:32:08.687] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:08.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:90:0) after 1m0s
[00:33:08.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:90:0)
[00:33:08.840] Timer tick, asking Buildbucket for the build status
[00:33:08.907] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:08.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:91:0) after 1m0s
[00:34:09.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:91:0)
[00:34:09.142] Timer tick, asking Buildbucket for the build status
[00:34:09.222] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:09.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:92:0) after 1m0s
[00:35:09.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:92:0)
[00:35:09.307] Timer tick, asking Buildbucket for the build status
[00:35:09.423] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:09.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:93:0) after 1m0s
[00:36:09.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:93:0)
[00:36:09.512] Timer tick, asking Buildbucket for the build status
[00:36:09.855] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:09.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:94:0) after 1m0s
[00:37:09.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:94:0)
[00:37:09.890] Timer tick, asking Buildbucket for the build status
[00:37:10.115] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:10.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:95:0) after 1m0s
[00:38:10.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:95:0)
[00:38:10.206] Timer tick, asking Buildbucket for the build status
[00:38:10.388] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:10.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:96:0) after 1m0s
[00:39:10.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:96:0)
[00:39:10.380] Timer tick, asking Buildbucket for the build status
[00:39:10.453] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:10.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:97:0) after 1m0s
[00:40:10.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:97:0)
[00:40:10.500] Timer tick, asking Buildbucket for the build status
[00:40:11.074] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:11.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:98:0) after 1m0s
[00:41:11.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:98:0)
[00:41:11.118] Timer tick, asking Buildbucket for the build status
[00:41:11.202] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:11.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:99:0) after 1m0s
[00:42:11.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:99:0)
[00:42:11.263] Timer tick, asking Buildbucket for the build status
[00:42:11.467] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:11.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:100:0) after 1m0s
[00:43:11.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:100:0)
[00:43:11.543] Timer tick, asking Buildbucket for the build status
[00:43:11.727] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:11.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:101:0) after 1m0s
[00:44:11.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:101:0)
[00:44:11.805] Timer tick, asking Buildbucket for the build status
[00:44:12.586] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:12.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:102:0) after 1m0s
[00:45:12.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:102:0)
[00:45:12.609] Timer tick, asking Buildbucket for the build status
[00:45:12.740] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:12.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:103:0) after 1m0s
[00:46:12.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:103:0)
[00:46:12.840] Timer tick, asking Buildbucket for the build status
[00:46:12.932] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:12.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:104:0) after 1m0s
[00:47:13.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:104:0)
[00:47:13.092] Timer tick, asking Buildbucket for the build status
[00:47:13.359] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:13.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:105:0) after 1m0s
[00:48:13.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:105:0)
[00:48:13.495] Timer tick, asking Buildbucket for the build status
[00:48:13.646] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:13.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:106:0) after 1m0s
[00:49:13.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:106:0)
[00:49:13.833] Timer tick, asking Buildbucket for the build status
[00:49:14.067] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:14.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:107:0) after 1m0s
[00:50:14.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:107:0)
[00:50:14.159] Timer tick, asking Buildbucket for the build status
[00:50:14.322] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:14.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:108:0) after 1m0s
[00:51:14.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:108:0)
[00:51:14.354] Timer tick, asking Buildbucket for the build status
[00:51:14.419] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:14.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:109:0) after 1m0s
[00:52:14.400] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:109:0)
[00:52:14.400] Timer tick, asking Buildbucket for the build status
[00:52:14.492] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:14.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:110:0) after 1m0s
[00:53:14.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:110:0)
[00:53:14.556] Timer tick, asking Buildbucket for the build status
[00:53:14.753] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:14.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:111:0) after 1m0s
[00:54:14.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:111:0)
[00:54:14.841] Timer tick, asking Buildbucket for the build status
[00:54:15.036] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:15.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:112:0) after 1m0s
[00:55:15.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:112:0)
[00:55:15.070] Timer tick, asking Buildbucket for the build status
[00:55:15.214] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:15.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:113:0) after 1m0s
[00:56:15.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:113:0)
[00:56:15.274] Timer tick, asking Buildbucket for the build status
[00:56:15.617] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:15.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:114:0) after 1m0s
[00:57:15.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:114:0)
[00:57:15.741] Timer tick, asking Buildbucket for the build status
[00:57:15.837] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:15.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:115:0) after 1m0s
[00:58:15.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:115:0)
[00:58:15.922] Timer tick, asking Buildbucket for the build status
[00:58:15.988] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:15.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:116:0) after 1m0s
[00:59:16.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:116:0)
[00:59:16.016] Timer tick, asking Buildbucket for the build status
[00:59:16.346] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:16.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:117:0) after 1m0s
[01:00:16.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:117:0)
[01:00:16.384] Timer tick, asking Buildbucket for the build status
[01:00:16.573] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:16.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:118:0) after 1m0s
[01:01:16.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:118:0)
[01:01:16.611] Timer tick, asking Buildbucket for the build status
[01:01:16.687] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:16.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:119:0) after 1m0s
[01:02:16.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:119:0)
[01:02:16.731] Timer tick, asking Buildbucket for the build status
[01:02:17.630] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:17.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:120:0) after 1m0s
[01:03:17.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:120:0)
[01:03:17.763] Timer tick, asking Buildbucket for the build status
[01:03:17.896] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:17.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:121:0) after 1m0s
[01:04:18.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:121:0)
[01:04:18.151] Timer tick, asking Buildbucket for the build status
[01:04:18.413] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:18.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:122:0) after 1m0s
[01:05:18.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:122:0)
[01:05:18.492] Timer tick, asking Buildbucket for the build status
[01:05:18.706] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:18.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:123:0) after 1m0s
[01:06:18.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:123:0)
[01:06:18.758] Timer tick, asking Buildbucket for the build status
[01:06:18.890] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:18.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:124:0) after 1m0s
[01:07:19.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:124:0)
[01:07:19.082] Timer tick, asking Buildbucket for the build status
[01:07:19.199] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:19.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:125:0) after 1m0s
[01:08:19.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:125:0)
[01:08:19.262] Timer tick, asking Buildbucket for the build status
[01:08:19.552] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:19.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:126:0) after 1m0s
[01:09:19.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:126:0)
[01:09:19.657] Timer tick, asking Buildbucket for the build status
[01:09:19.924] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:19.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:127:0) after 1m0s
[01:10:19.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:127:0)
[01:10:19.988] Timer tick, asking Buildbucket for the build status
[01:10:20.429] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:20.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:128:0) after 1m0s
[01:11:20.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:128:0)
[01:11:20.533] Timer tick, asking Buildbucket for the build status
[01:11:20.690] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:20.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:129:0) after 1m0s
[01:12:20.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:129:0)
[01:12:20.777] Timer tick, asking Buildbucket for the build status
[01:12:21.132] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:21.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:130:0) after 1m0s
[01:13:21.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:130:0)
[01:13:21.237] Timer tick, asking Buildbucket for the build status
[01:13:21.303] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:21.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:131:0) after 1m0s
[01:14:21.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:131:0)
[01:14:21.380] Timer tick, asking Buildbucket for the build status
[01:14:21.525] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:21.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:132:0) after 1m0s
[01:15:21.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:132:0)
[01:15:21.675] Timer tick, asking Buildbucket for the build status
[01:15:21.966] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:21.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:133:0) after 1m0s
[01:16:22.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:133:0)
[01:16:22.132] Timer tick, asking Buildbucket for the build status
[01:16:22.395] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:22.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:134:0) after 1m0s
[01:17:22.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:134:0)
[01:17:22.450] Timer tick, asking Buildbucket for the build status
[01:17:22.524] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:22.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:135:0) after 1m0s
[01:18:22.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:135:0)
[01:18:22.746] Timer tick, asking Buildbucket for the build status
[01:18:22.941] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:22.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:136:0) after 1m0s
[01:19:23.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:136:0)
[01:19:23.147] Timer tick, asking Buildbucket for the build status
[01:19:23.304] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:23.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:137:0) after 1m0s
[01:20:23.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:137:0)
[01:20:23.451] Timer tick, asking Buildbucket for the build status
[01:20:23.607] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:23.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:138:0) after 1m0s
[01:21:23.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:138:0)
[01:21:23.692] Timer tick, asking Buildbucket for the build status
[01:21:23.972] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:23.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:139:0) after 1m0s
[01:22:24.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:139:0)
[01:22:24.124] Timer tick, asking Buildbucket for the build status
[01:22:24.205] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:24.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:140:0) after 1m0s
[01:23:24.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:140:0)
[01:23:24.333] Timer tick, asking Buildbucket for the build status
[01:23:25.193] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:25.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:141:0) after 1m0s
[01:24:25.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:141:0)
[01:24:25.223] Timer tick, asking Buildbucket for the build status
[01:24:25.432] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:25.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:142:0) after 1m0s
[01:25:25.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:142:0)
[01:25:25.465] Timer tick, asking Buildbucket for the build status
[01:25:25.688] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:25.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:143:0) after 1m0s
[01:26:25.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:143:0)
[01:26:25.722] Timer tick, asking Buildbucket for the build status
[01:26:25.884] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:25.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:144:0) after 1m0s
[01:27:26.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:144:0)
[01:27:26.026] Timer tick, asking Buildbucket for the build status
[01:27:26.221] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:26.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:145:0) after 1m0s
[01:28:26.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:145:0)
[01:28:26.344] Timer tick, asking Buildbucket for the build status
[01:28:26.453] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:26.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:146:0) after 1m0s
[01:29:26.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:146:0)
[01:29:26.455] Timer tick, asking Buildbucket for the build status
[01:29:26.518] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:26.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:147:0) after 1m0s
[01:30:26.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:147:0)
[01:30:26.557] Timer tick, asking Buildbucket for the build status
[01:30:26.651] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:26.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:148:0) after 1m0s
[01:31:26.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:148:0)
[01:31:26.734] Timer tick, asking Buildbucket for the build status
[01:31:27.080] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:27.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:149:0) after 1m0s
[01:32:27.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:149:0)
[01:32:27.210] Timer tick, asking Buildbucket for the build status
[01:32:27.277] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:27.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:150:0) after 1m0s
[01:33:27.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:150:0)
[01:33:27.340] Timer tick, asking Buildbucket for the build status
[01:33:27.482] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:27.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:151:0) after 1m0s
[01:34:27.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:151:0)
[01:34:27.522] Timer tick, asking Buildbucket for the build status
[01:34:27.623] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:27.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:152:0) after 1m0s
[01:35:27.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:152:0)
[01:35:27.721] Timer tick, asking Buildbucket for the build status
[01:35:28.175] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:28.175] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:153:0) after 1m0s
[01:36:28.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:153:0)
[01:36:28.298] Timer tick, asking Buildbucket for the build status
[01:36:28.383] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:28.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:154:0) after 1m0s
[01:37:28.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:154:0)
[01:37:28.472] Timer tick, asking Buildbucket for the build status
[01:37:28.547] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:28.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:155:0) after 1m0s
[01:38:28.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:155:0)
[01:38:28.543] Timer tick, asking Buildbucket for the build status
[01:38:28.617] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:28.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:156:0) after 1m0s
[01:39:28.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:156:0)
[01:39:28.764] Timer tick, asking Buildbucket for the build status
[01:39:28.843] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:28.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:157:0) after 1m0s
[01:40:29.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:157:0)
[01:40:29.088] Timer tick, asking Buildbucket for the build status
[01:40:29.402] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:29.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:158:0) after 1m0s
[01:41:29.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:158:0)
[01:41:29.465] Timer tick, asking Buildbucket for the build status
[01:41:29.587] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:29.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:159:0) after 1m0s
[01:42:29.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:159:0)
[01:42:29.618] Timer tick, asking Buildbucket for the build status
[01:42:29.766] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:29.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:160:0) after 1m0s
[01:43:29.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:160:0)
[01:43:29.809] Timer tick, asking Buildbucket for the build status
[01:43:30.000] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:30.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:161:0) after 1m0s
[01:44:30.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:161:0)
[01:44:30.010] Timer tick, asking Buildbucket for the build status
[01:44:30.217] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:30.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:162:0) after 1m0s
[01:45:30.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:162:0)
[01:45:30.262] Timer tick, asking Buildbucket for the build status
[01:45:30.428] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:30.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:163:0) after 1m0s
[01:46:30.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:163:0)
[01:46:30.628] Timer tick, asking Buildbucket for the build status
[01:46:30.697] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:30.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:164:0) after 1m0s
[01:47:30.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:164:0)
[01:47:30.729] Timer tick, asking Buildbucket for the build status
[01:47:30.797] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:30.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:165:0) after 1m0s
[01:48:30.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:165:0)
[01:48:30.848] Timer tick, asking Buildbucket for the build status
[01:48:31.044] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:31.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:166:0) after 1m0s
[01:49:31.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:166:0)
[01:49:31.093] Timer tick, asking Buildbucket for the build status
[01:49:31.164] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:31.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:167:0) after 1m0s
[01:50:31.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:167:0)
[01:50:31.336] Timer tick, asking Buildbucket for the build status
[01:50:31.802] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:31.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:168:0) after 1m0s
[01:51:31.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:168:0)
[01:51:31.886] Timer tick, asking Buildbucket for the build status
[01:51:32.158] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:32.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:169:0) after 1m0s
[01:52:32.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:169:0)
[01:52:32.189] Timer tick, asking Buildbucket for the build status
[01:52:32.258] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:32.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:170:0) after 1m0s
[01:53:32.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:170:0)
[01:53:32.347] Timer tick, asking Buildbucket for the build status
[01:53:32.670] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:32.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:171:0) after 1m0s
[01:54:32.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:171:0)
[01:54:32.834] Timer tick, asking Buildbucket for the build status
[01:54:32.946] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:32.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:172:0) after 1m0s
[01:55:32.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:172:0)
[01:55:32.957] Timer tick, asking Buildbucket for the build status
[01:55:33.102] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:33.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:173:0) after 1m0s
[01:56:33.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:173:0)
[01:56:33.204] Timer tick, asking Buildbucket for the build status
[01:56:33.346] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:33.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:174:0) after 1m0s
[01:57:33.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:174:0)
[01:57:33.398] Timer tick, asking Buildbucket for the build status
[01:57:33.610] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:33.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:175:0) after 1m0s
[01:58:33.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:175:0)
[01:58:33.688] Timer tick, asking Buildbucket for the build status
[01:58:33.758] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:33.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:176:0) after 1m0s
[01:59:33.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:176:0)
[01:59:33.811] Timer tick, asking Buildbucket for the build status
[01:59:33.874] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:33.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:177:0) after 1m0s
[02:00:34.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:177:0)
[02:00:34.038] Timer tick, asking Buildbucket for the build status
[02:00:34.975] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:34.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:178:0) after 1m0s
[02:01:34.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:178:0)
[02:01:34.997] Timer tick, asking Buildbucket for the build status
[02:01:35.207] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:35.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:179:0) after 1m0s
[02:02:35.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:179:0)
[02:02:35.257] Timer tick, asking Buildbucket for the build status
[02:02:35.311] Build 8872765258111466944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:35.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038195320165835168:180:0) after 1m0s
[02:03:29.306] Received PubSub notification, asking Buildbucket for the build status
[02:03:29.725] Build 8872765258111466944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:03:29.725] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596679408615723",
    "created_by": "project:infra",
    "created_ts": "1596668680045819",
    "id": "8872765258111466944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4222.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"0020d555-0570-407f-96ad-6ef902da5da4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4222.4\"}}",
    "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-vqrk\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596668723464130",
    "status": "COMPLETED",
    "status_changed_ts": "1596679408937948",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038195320165835168",
      "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/8872765258111466944/+/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:4dd9b0349afe2110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596679408955752",
    "url": "https://ci.chromium.org/b/8872765258111466944",
    "utcnow_ts": "1596679409694812"
  }
}
[02:03:29.725] Invocation finished in 2h58m51.023716745s with status SUCCEEDED