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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:57:10.298] New invocation is queued and will start shortly
[07:57:10.298] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:57:11.380] Starting the invocation (attempt 1)
[07:57:11.423] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:57:11.423] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:57:11.423] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9040245546733432832",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4202.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e5ac5cce-1790-43ee-afba-af8bc1347d1f\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4202.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9040245546733432832",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:57:15.472] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1594713431783162",
    "id": "8874815484513482272",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4202.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e5ac5cce-1790-43ee-afba-af8bc1347d1f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4202.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594713434036134",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040245546733432832",
      "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/8874815484513482272/+/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": "1594713434036293",
    "url": "https://ci.chromium.org/b/8874815484513482272",
    "utcnow_ts": "1594713435396609"
  }
}
[07:57:15.472] Task URL: https://ci.chromium.org/b/8874815484513482272
[07:57:15.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:2:0) after 1m0s
[07:57:17.980] Received PubSub notification, asking Buildbucket for the build status
[07:57:18.585] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:15.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:2:0)
[07:58:15.534] Timer tick, asking Buildbucket for the build status
[07:58:15.811] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:15.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:4:0) after 1m0s
[07:59:15.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:4:0)
[07:59:15.829] Timer tick, asking Buildbucket for the build status
[07:59:16.043] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:16.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:5:0) after 1m0s
[08:00:16.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:5:0)
[08:00:16.168] Timer tick, asking Buildbucket for the build status
[08:00:16.341] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:16.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:6:0) after 1m0s
[08:01:16.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:6:0)
[08:01:16.363] Timer tick, asking Buildbucket for the build status
[08:01:16.805] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:16.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:7:0) after 1m0s
[08:02:16.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:7:0)
[08:02:16.863] Timer tick, asking Buildbucket for the build status
[08:02:17.159] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:17.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:8:0) after 1m0s
[08:03:17.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:8:0)
[08:03:17.181] Timer tick, asking Buildbucket for the build status
[08:03:17.308] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:17.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:9:0) after 1m0s
[08:04:17.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:9:0)
[08:04:17.377] Timer tick, asking Buildbucket for the build status
[08:04:18.700] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:18.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:10:0) after 1m0s
[08:05:18.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:10:0)
[08:05:18.848] Timer tick, asking Buildbucket for the build status
[08:05:19.005] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:19.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:11:0) after 1m0s
[08:06:19.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:11:0)
[08:06:19.031] Timer tick, asking Buildbucket for the build status
[08:06:19.156] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:19.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:12:0) after 1m0s
[08:07:19.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:12:0)
[08:07:19.226] Timer tick, asking Buildbucket for the build status
[08:07:19.513] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:19.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:13:0) after 1m0s
[08:08:19.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:13:0)
[08:08:19.542] Timer tick, asking Buildbucket for the build status
[08:08:19.662] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:19.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:14:0) after 1m0s
[08:09:19.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:14:0)
[08:09:19.674] Timer tick, asking Buildbucket for the build status
[08:09:19.961] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:19.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:15:0) after 1m0s
[08:10:20.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:15:0)
[08:10:20.047] Timer tick, asking Buildbucket for the build status
[08:10:20.741] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:20.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:16:0) after 1m0s
[08:11:20.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:16:0)
[08:11:20.816] Timer tick, asking Buildbucket for the build status
[08:11:21.212] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:21.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:17:0) after 1m0s
[08:12:21.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:17:0)
[08:12:21.234] Timer tick, asking Buildbucket for the build status
[08:12:21.400] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:21.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:18:0) after 1m0s
[08:13:21.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:18:0)
[08:13:21.492] Timer tick, asking Buildbucket for the build status
[08:13:21.608] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:21.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:19:0) after 1m0s
[08:14:21.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:19:0)
[08:14:21.667] Timer tick, asking Buildbucket for the build status
[08:14:21.832] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:21.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:20:0) after 1m0s
[08:15:21.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:20:0)
[08:15:21.949] Timer tick, asking Buildbucket for the build status
[08:15:22.427] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:22.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:21:0) after 1m0s
[08:16:22.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:21:0)
[08:16:22.448] Timer tick, asking Buildbucket for the build status
[08:16:22.581] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:22.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:22:0) after 1m0s
[08:17:22.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:22:0)
[08:17:22.603] Timer tick, asking Buildbucket for the build status
[08:17:22.771] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:22.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:23:0) after 1m0s
[08:18:22.814] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:23:0)
[08:18:22.814] Timer tick, asking Buildbucket for the build status
[08:18:23.026] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:23.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:24:0) after 1m0s
[08:19:23.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:24:0)
[08:19:23.144] Timer tick, asking Buildbucket for the build status
[08:19:23.312] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:23.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:25:0) after 1m0s
[08:20:23.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:25:0)
[08:20:23.419] Timer tick, asking Buildbucket for the build status
[08:20:23.571] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:23.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:26:0) after 1m0s
[08:21:23.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:26:0)
[08:21:23.644] Timer tick, asking Buildbucket for the build status
[08:21:24.326] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:24.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:27:0) after 1m0s
[08:22:24.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:27:0)
[08:22:24.348] Timer tick, asking Buildbucket for the build status
[08:22:24.537] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:24.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:28:0) after 1m0s
[08:23:24.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:28:0)
[08:23:24.591] Timer tick, asking Buildbucket for the build status
[08:23:24.719] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:24.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:29:0) after 1m0s
[08:24:24.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:29:0)
[08:24:24.742] Timer tick, asking Buildbucket for the build status
[08:24:25.117] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:25.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:30:0) after 1m0s
[08:25:25.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:30:0)
[08:25:25.159] Timer tick, asking Buildbucket for the build status
[08:25:25.348] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:25.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:31:0) after 1m0s
[08:26:25.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:31:0)
[08:26:25.472] Timer tick, asking Buildbucket for the build status
[08:26:26.101] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:26.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:32:0) after 1m0s
[08:27:26.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:32:0)
[08:27:26.169] Timer tick, asking Buildbucket for the build status
[08:27:26.402] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:26.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:33:0) after 1m0s
[08:28:26.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:33:0)
[08:28:26.426] Timer tick, asking Buildbucket for the build status
[08:28:26.658] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:26.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:34:0) after 1m0s
[08:29:26.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:34:0)
[08:29:26.728] Timer tick, asking Buildbucket for the build status
[08:29:26.927] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:26.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:35:0) after 1m0s
[08:30:26.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:35:0)
[08:30:26.917] Timer tick, asking Buildbucket for the build status
[08:30:27.057] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:27.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:36:0) after 1m0s
[08:31:27.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:36:0)
[08:31:27.112] Timer tick, asking Buildbucket for the build status
[08:31:27.376] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:27.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:37:0) after 1m0s
[08:32:27.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:37:0)
[08:32:27.489] Timer tick, asking Buildbucket for the build status
[08:32:27.677] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:27.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:38:0) after 1m0s
[08:33:27.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:38:0)
[08:33:27.702] Timer tick, asking Buildbucket for the build status
[08:33:27.871] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:27.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:39:0) after 1m0s
[08:34:27.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:39:0)
[08:34:27.897] Timer tick, asking Buildbucket for the build status
[08:34:28.040] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:28.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:40:0) after 1m0s
[08:35:28.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:40:0)
[08:35:28.349] Timer tick, asking Buildbucket for the build status
[08:35:28.510] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:28.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:41:0) after 1m0s
[08:36:28.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:41:0)
[08:36:28.574] Timer tick, asking Buildbucket for the build status
[08:36:28.883] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:28.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:42:0) after 1m0s
[08:37:28.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:42:0)
[08:37:28.967] Timer tick, asking Buildbucket for the build status
[08:37:29.122] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:29.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:43:0) after 1m0s
[08:38:29.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:43:0)
[08:38:29.334] Timer tick, asking Buildbucket for the build status
[08:38:29.619] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:29.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:44:0) after 1m0s
[08:39:29.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:44:0)
[08:39:29.633] Timer tick, asking Buildbucket for the build status
[08:39:30.120] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:30.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:45:0) after 1m0s
[08:40:30.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:45:0)
[08:40:30.166] Timer tick, asking Buildbucket for the build status
[08:40:30.333] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:30.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:46:0) after 1m0s
[08:41:30.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:46:0)
[08:41:30.361] Timer tick, asking Buildbucket for the build status
[08:41:30.671] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:30.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:47:0) after 1m0s
[08:42:30.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:47:0)
[08:42:30.803] Timer tick, asking Buildbucket for the build status
[08:42:30.963] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:30.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:48:0) after 1m0s
[08:43:30.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:48:0)
[08:43:30.996] Timer tick, asking Buildbucket for the build status
[08:43:31.190] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:31.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:49:0) after 1m0s
[08:44:31.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:49:0)
[08:44:31.379] Timer tick, asking Buildbucket for the build status
[08:44:31.534] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:31.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:50:0) after 1m0s
[08:45:31.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:50:0)
[08:45:31.548] Timer tick, asking Buildbucket for the build status
[08:45:31.859] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:31.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:51:0) after 1m0s
[08:46:31.912] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:51:0)
[08:46:31.912] Timer tick, asking Buildbucket for the build status
[08:46:32.632] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:32.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:52:0) after 1m0s
[08:47:32.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:52:0)
[08:47:32.660] Timer tick, asking Buildbucket for the build status
[08:47:33.033] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:33.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:53:0) after 1m0s
[08:48:33.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:53:0)
[08:48:33.106] Timer tick, asking Buildbucket for the build status
[08:48:33.320] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:33.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:54:0) after 1m0s
[08:49:33.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:54:0)
[08:49:33.344] Timer tick, asking Buildbucket for the build status
[08:49:33.590] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:33.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:55:0) after 1m0s
[08:50:33.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:55:0)
[08:50:33.617] Timer tick, asking Buildbucket for the build status
[08:50:33.768] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:33.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:56:0) after 1m0s
[08:51:33.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:56:0)
[08:51:33.794] Timer tick, asking Buildbucket for the build status
[08:51:34.018] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:34.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:57:0) after 1m0s
[08:52:34.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:57:0)
[08:52:34.046] Timer tick, asking Buildbucket for the build status
[08:52:34.231] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:34.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:58:0) after 1m0s
[08:53:34.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:58:0)
[08:53:34.266] Timer tick, asking Buildbucket for the build status
[08:53:34.414] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:34.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:59:0) after 1m0s
[08:54:34.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:59:0)
[08:54:34.506] Timer tick, asking Buildbucket for the build status
[08:54:35.217] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:35.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:60:0) after 1m0s
[08:55:35.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:60:0)
[08:55:35.242] Timer tick, asking Buildbucket for the build status
[08:55:35.614] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:35.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:61:0) after 1m0s
[08:56:35.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:61:0)
[08:56:35.862] Timer tick, asking Buildbucket for the build status
[08:56:36.182] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:36.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:62:0) after 1m0s
[08:57:36.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:62:0)
[08:57:36.234] Timer tick, asking Buildbucket for the build status
[08:57:36.813] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:36.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:63:0) after 1m0s
[08:58:37.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:63:0)
[08:58:37.027] Timer tick, asking Buildbucket for the build status
[08:58:37.181] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:37.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:64:0) after 1m0s
[08:59:37.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:64:0)
[08:59:37.253] Timer tick, asking Buildbucket for the build status
[08:59:37.442] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:37.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:65:0) after 1m0s
[09:00:37.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:65:0)
[09:00:37.525] Timer tick, asking Buildbucket for the build status
[09:00:37.693] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:37.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:66:0) after 1m0s
[09:01:37.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:66:0)
[09:01:37.715] Timer tick, asking Buildbucket for the build status
[09:01:38.120] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:38.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:67:0) after 1m0s
[09:02:38.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:67:0)
[09:02:38.244] Timer tick, asking Buildbucket for the build status
[09:02:38.502] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:38.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:68:0) after 1m0s
[09:03:38.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:68:0)
[09:03:38.753] Timer tick, asking Buildbucket for the build status
[09:03:38.857] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:38.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:69:0) after 1m0s
[09:04:38.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:69:0)
[09:04:38.891] Timer tick, asking Buildbucket for the build status
[09:04:39.017] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:39.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:70:0) after 1m0s
[09:05:39.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:70:0)
[09:05:39.063] Timer tick, asking Buildbucket for the build status
[09:05:39.463] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:39.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:71:0) after 1m0s
[09:06:39.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:71:0)
[09:06:39.548] Timer tick, asking Buildbucket for the build status
[09:06:39.864] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:39.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:72:0) after 1m0s
[09:07:39.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:72:0)
[09:07:39.901] Timer tick, asking Buildbucket for the build status
[09:07:40.073] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:40.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:73:0) after 1m0s
[09:08:40.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:73:0)
[09:08:40.107] Timer tick, asking Buildbucket for the build status
[09:08:40.214] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:40.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:74:0) after 1m0s
[09:09:40.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:74:0)
[09:09:40.281] Timer tick, asking Buildbucket for the build status
[09:09:40.553] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:40.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:75:0) after 1m0s
[09:10:40.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:75:0)
[09:10:40.581] Timer tick, asking Buildbucket for the build status
[09:10:40.851] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:40.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:76:0) after 1m0s
[09:11:40.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:76:0)
[09:11:40.937] Timer tick, asking Buildbucket for the build status
[09:11:41.245] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:41.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:77:0) after 1m0s
[09:12:41.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:77:0)
[09:12:41.269] Timer tick, asking Buildbucket for the build status
[09:12:41.689] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:41.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:78:0) after 1m0s
[09:13:41.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:78:0)
[09:13:41.770] Timer tick, asking Buildbucket for the build status
[09:13:42.896] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:42.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:79:0) after 1m0s
[09:14:42.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:79:0)
[09:14:42.988] Timer tick, asking Buildbucket for the build status
[09:14:43.171] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:43.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:80:0) after 1m0s
[09:15:43.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:80:0)
[09:15:43.208] Timer tick, asking Buildbucket for the build status
[09:15:43.354] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:43.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:81:0) after 1m0s
[09:16:43.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:81:0)
[09:16:43.379] Timer tick, asking Buildbucket for the build status
[09:16:45.466] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:45.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:82:0) after 1m0s
[09:17:45.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:82:0)
[09:17:45.731] Timer tick, asking Buildbucket for the build status
[09:17:45.865] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:45.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:83:0) after 1m0s
[09:18:46.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:83:0)
[09:18:46.088] Timer tick, asking Buildbucket for the build status
[09:18:46.255] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:46.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:84:0) after 1m0s
[09:19:46.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:84:0)
[09:19:46.410] Timer tick, asking Buildbucket for the build status
[09:19:46.540] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:46.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:85:0) after 1m0s
[09:20:46.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:85:0)
[09:20:46.721] Timer tick, asking Buildbucket for the build status
[09:20:46.843] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:46.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:86:0) after 1m0s
[09:21:47.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:86:0)
[09:21:47.075] Timer tick, asking Buildbucket for the build status
[09:21:47.341] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:47.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:87:0) after 1m0s
[09:22:47.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:87:0)
[09:22:47.561] Timer tick, asking Buildbucket for the build status
[09:22:47.936] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:47.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:88:0) after 1m0s
[09:23:47.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:88:0)
[09:23:47.996] Timer tick, asking Buildbucket for the build status
[09:23:48.171] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:48.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:89:0) after 1m0s
[09:24:48.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:89:0)
[09:24:48.245] Timer tick, asking Buildbucket for the build status
[09:24:48.702] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:48.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:90:0) after 1m0s
[09:25:48.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:90:0)
[09:25:48.786] Timer tick, asking Buildbucket for the build status
[09:25:48.914] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:48.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:91:0) after 1m0s
[09:26:48.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:91:0)
[09:26:48.980] Timer tick, asking Buildbucket for the build status
[09:26:49.111] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:49.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:92:0) after 1m0s
[09:27:49.221] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:92:0)
[09:27:49.222] Timer tick, asking Buildbucket for the build status
[09:27:49.813] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:49.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:93:0) after 1m0s
[09:28:49.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:93:0)
[09:28:49.900] Timer tick, asking Buildbucket for the build status
[09:28:50.054] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:50.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:94:0) after 1m0s
[09:29:50.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:94:0)
[09:29:50.138] Timer tick, asking Buildbucket for the build status
[09:29:50.235] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:50.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:95:0) after 1m0s
[09:30:50.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:95:0)
[09:30:50.362] Timer tick, asking Buildbucket for the build status
[09:30:50.487] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:50.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:96:0) after 1m0s
[09:31:50.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:96:0)
[09:31:50.519] Timer tick, asking Buildbucket for the build status
[09:31:50.628] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:50.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:97:0) after 1m0s
[09:32:50.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:97:0)
[09:32:50.702] Timer tick, asking Buildbucket for the build status
[09:32:51.095] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:51.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:98:0) after 1m0s
[09:33:51.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:98:0)
[09:33:51.188] Timer tick, asking Buildbucket for the build status
[09:33:51.300] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:51.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:99:0) after 1m0s
[09:34:51.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:99:0)
[09:34:51.351] Timer tick, asking Buildbucket for the build status
[09:34:51.619] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:51.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:100:0) after 1m0s
[09:35:51.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:100:0)
[09:35:51.721] Timer tick, asking Buildbucket for the build status
[09:35:51.992] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:51.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:101:0) after 1m0s
[09:36:52.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:101:0)
[09:36:52.074] Timer tick, asking Buildbucket for the build status
[09:36:52.197] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:52.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:102:0) after 1m0s
[09:37:52.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:102:0)
[09:37:52.247] Timer tick, asking Buildbucket for the build status
[09:37:52.423] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:52.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:103:0) after 1m0s
[09:38:52.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:103:0)
[09:38:52.452] Timer tick, asking Buildbucket for the build status
[09:38:52.753] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:52.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:104:0) after 1m0s
[09:39:52.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:104:0)
[09:39:52.834] Timer tick, asking Buildbucket for the build status
[09:39:53.297] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:53.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:105:0) after 1m0s
[09:40:53.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:105:0)
[09:40:53.337] Timer tick, asking Buildbucket for the build status
[09:40:53.575] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:53.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:106:0) after 1m0s
[09:41:53.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:106:0)
[09:41:53.616] Timer tick, asking Buildbucket for the build status
[09:41:53.942] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:53.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:107:0) after 1m0s
[09:42:53.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:107:0)
[09:42:53.981] Timer tick, asking Buildbucket for the build status
[09:42:54.218] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:54.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:108:0) after 1m0s
[09:43:54.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:108:0)
[09:43:54.249] Timer tick, asking Buildbucket for the build status
[09:43:54.505] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:54.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:109:0) after 1m0s
[09:44:54.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:109:0)
[09:44:54.564] Timer tick, asking Buildbucket for the build status
[09:44:54.845] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:54.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:110:0) after 1m0s
[09:45:54.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:110:0)
[09:45:54.874] Timer tick, asking Buildbucket for the build status
[09:45:54.998] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:54.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:111:0) after 1m0s
[09:46:55.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:111:0)
[09:46:55.035] Timer tick, asking Buildbucket for the build status
[09:46:55.589] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:55.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:112:0) after 1m0s
[09:47:55.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:112:0)
[09:47:55.628] Timer tick, asking Buildbucket for the build status
[09:47:55.760] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:55.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:113:0) after 1m0s
[09:48:55.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:113:0)
[09:48:55.787] Timer tick, asking Buildbucket for the build status
[09:48:56.186] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:56.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:114:0) after 1m0s
[09:49:56.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:114:0)
[09:49:56.316] Timer tick, asking Buildbucket for the build status
[09:49:56.441] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:56.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:115:0) after 1m0s
[09:50:56.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:115:0)
[09:50:56.567] Timer tick, asking Buildbucket for the build status
[09:50:56.689] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:56.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:116:0) after 1m0s
[09:51:56.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:116:0)
[09:51:56.773] Timer tick, asking Buildbucket for the build status
[09:51:56.950] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:56.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:117:0) after 1m0s
[09:52:56.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:117:0)
[09:52:56.977] Timer tick, asking Buildbucket for the build status
[09:52:57.083] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:57.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:118:0) after 1m0s
[09:53:57.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:118:0)
[09:53:57.162] Timer tick, asking Buildbucket for the build status
[09:53:57.504] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:57.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:119:0) after 1m0s
[09:54:57.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:119:0)
[09:54:57.546] Timer tick, asking Buildbucket for the build status
[09:54:57.778] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:57.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:120:0) after 1m0s
[09:55:57.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:120:0)
[09:55:57.813] Timer tick, asking Buildbucket for the build status
[09:55:58.150] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:58.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:121:0) after 1m0s
[09:56:58.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:121:0)
[09:56:58.259] Timer tick, asking Buildbucket for the build status
[09:56:58.411] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:58.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:122:0) after 1m0s
[09:57:58.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:122:0)
[09:57:58.440] Timer tick, asking Buildbucket for the build status
[09:57:59.337] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:59.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:123:0) after 1m0s
[09:58:59.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:123:0)
[09:58:59.451] Timer tick, asking Buildbucket for the build status
[09:58:59.548] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:59.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:124:0) after 1m0s
[09:59:59.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:124:0)
[09:59:59.583] Timer tick, asking Buildbucket for the build status
[09:59:59.691] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:59.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:125:0) after 1m0s
[10:00:59.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:125:0)
[10:00:59.725] Timer tick, asking Buildbucket for the build status
[10:00:59.845] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:59.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:126:0) after 1m0s
[10:01:59.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:126:0)
[10:01:59.922] Timer tick, asking Buildbucket for the build status
[10:02:00.201] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:00.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:127:0) after 1m0s
[10:03:00.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:127:0)
[10:03:00.236] Timer tick, asking Buildbucket for the build status
[10:03:00.437] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:00.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:128:0) after 1m0s
[10:04:00.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:128:0)
[10:04:00.473] Timer tick, asking Buildbucket for the build status
[10:04:00.776] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:00.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:129:0) after 1m0s
[10:05:02.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:129:0)
[10:05:02.448] Timer tick, asking Buildbucket for the build status
[10:05:02.562] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:02.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:130:0) after 1m0s
[10:06:02.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:130:0)
[10:06:02.657] Timer tick, asking Buildbucket for the build status
[10:06:03.013] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:03.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:131:0) after 1m0s
[10:07:03.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:131:0)
[10:07:03.269] Timer tick, asking Buildbucket for the build status
[10:07:03.790] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:03.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:132:0) after 1m0s
[10:08:03.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:132:0)
[10:08:03.846] Timer tick, asking Buildbucket for the build status
[10:08:04.202] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:04.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:133:0) after 1m0s
[10:09:04.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:133:0)
[10:09:04.242] Timer tick, asking Buildbucket for the build status
[10:09:04.397] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:04.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:134:0) after 1m0s
[10:10:04.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:134:0)
[10:10:04.433] Timer tick, asking Buildbucket for the build status
[10:10:04.892] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:04.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:135:0) after 1m0s
[10:11:05.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:135:0)
[10:11:05.007] Timer tick, asking Buildbucket for the build status
[10:11:05.192] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:05.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:136:0) after 1m0s
[10:12:05.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:136:0)
[10:12:05.232] Timer tick, asking Buildbucket for the build status
[10:12:05.593] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:05.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:137:0) after 1m0s
[10:13:05.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:137:0)
[10:13:05.658] Timer tick, asking Buildbucket for the build status
[10:13:05.798] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:05.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:138:0) after 1m0s
[10:14:05.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:138:0)
[10:14:05.906] Timer tick, asking Buildbucket for the build status
[10:14:06.102] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:06.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:139:0) after 1m0s
[10:15:06.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:139:0)
[10:15:06.138] Timer tick, asking Buildbucket for the build status
[10:15:06.429] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:06.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:140:0) after 1m0s
[10:16:06.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:140:0)
[10:16:06.565] Timer tick, asking Buildbucket for the build status
[10:16:06.676] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:06.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:141:0) after 1m0s
[10:17:06.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:141:0)
[10:17:06.725] Timer tick, asking Buildbucket for the build status
[10:17:07.292] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:07.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:142:0) after 1m0s
[10:18:07.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:142:0)
[10:18:07.339] Timer tick, asking Buildbucket for the build status
[10:18:07.495] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:07.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:143:0) after 1m0s
[10:19:07.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:143:0)
[10:19:07.528] Timer tick, asking Buildbucket for the build status
[10:19:07.648] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:07.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:144:0) after 1m0s
[10:20:07.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:144:0)
[10:20:07.712] Timer tick, asking Buildbucket for the build status
[10:20:07.876] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:07.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:145:0) after 1m0s
[10:21:07.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:145:0)
[10:21:07.905] Timer tick, asking Buildbucket for the build status
[10:21:08.279] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:08.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:146:0) after 1m0s
[10:22:08.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:146:0)
[10:22:08.304] Timer tick, asking Buildbucket for the build status
[10:22:08.591] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:08.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:147:0) after 1m0s
[10:23:08.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:147:0)
[10:23:08.788] Timer tick, asking Buildbucket for the build status
[10:23:08.932] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:08.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:148:0) after 1m0s
[10:24:08.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:148:0)
[10:24:08.947] Timer tick, asking Buildbucket for the build status
[10:24:09.504] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:09.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:149:0) after 1m0s
[10:25:09.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:149:0)
[10:25:09.607] Timer tick, asking Buildbucket for the build status
[10:25:09.870] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:09.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:150:0) after 1m0s
[10:26:09.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:150:0)
[10:26:09.913] Timer tick, asking Buildbucket for the build status
[10:26:10.162] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:10.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:151:0) after 1m0s
[10:27:10.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:151:0)
[10:27:10.228] Timer tick, asking Buildbucket for the build status
[10:27:10.400] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:10.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:152:0) after 1m0s
[10:28:10.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:152:0)
[10:28:10.462] Timer tick, asking Buildbucket for the build status
[10:28:10.667] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:10.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:153:0) after 1m0s
[10:29:10.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:153:0)
[10:29:10.940] Timer tick, asking Buildbucket for the build status
[10:29:12.064] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:12.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:154:0) after 1m0s
[10:30:12.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:154:0)
[10:30:12.227] Timer tick, asking Buildbucket for the build status
[10:30:12.333] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:12.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:155:0) after 1m0s
[10:31:12.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:155:0)
[10:31:12.421] Timer tick, asking Buildbucket for the build status
[10:31:12.573] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:12.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:156:0) after 1m0s
[10:32:12.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:156:0)
[10:32:12.654] Timer tick, asking Buildbucket for the build status
[10:32:13.063] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:13.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:157:0) after 1m0s
[10:33:13.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:157:0)
[10:33:13.109] Timer tick, asking Buildbucket for the build status
[10:33:13.217] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:13.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:158:0) after 1m0s
[10:34:13.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:158:0)
[10:34:13.241] Timer tick, asking Buildbucket for the build status
[10:34:14.752] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:14.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:159:0) after 1m0s
[10:35:14.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:159:0)
[10:35:14.800] Timer tick, asking Buildbucket for the build status
[10:35:15.156] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:15.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:160:0) after 1m0s
[10:36:15.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:160:0)
[10:36:15.254] Timer tick, asking Buildbucket for the build status
[10:36:15.674] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:15.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:161:0) after 1m0s
[10:37:15.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:161:0)
[10:37:15.699] Timer tick, asking Buildbucket for the build status
[10:37:15.970] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:15.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:162:0) after 1m0s
[10:38:15.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:162:0)
[10:38:15.992] Timer tick, asking Buildbucket for the build status
[10:38:16.167] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:16.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:163:0) after 1m0s
[10:39:16.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:163:0)
[10:39:16.229] Timer tick, asking Buildbucket for the build status
[10:39:18.002] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:18.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:164:0) after 1m0s
[10:40:18.074] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:164:0)
[10:40:18.074] Timer tick, asking Buildbucket for the build status
[10:40:19.088] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:19.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:165:0) after 1m0s
[10:41:19.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:165:0)
[10:41:19.115] Timer tick, asking Buildbucket for the build status
[10:41:19.612] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:19.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:166:0) after 1m0s
[10:42:19.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:166:0)
[10:42:19.751] Timer tick, asking Buildbucket for the build status
[10:42:20.022] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:20.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:167:0) after 1m0s
[10:43:20.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:167:0)
[10:43:20.079] Timer tick, asking Buildbucket for the build status
[10:43:20.243] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:20.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:168:0) after 1m0s
[10:44:20.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:168:0)
[10:44:20.348] Timer tick, asking Buildbucket for the build status
[10:44:20.766] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:20.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:169:0) after 1m0s
[10:45:20.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:169:0)
[10:45:20.950] Timer tick, asking Buildbucket for the build status
[10:45:21.134] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:21.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:170:0) after 1m0s
[10:46:21.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:170:0)
[10:46:21.174] Timer tick, asking Buildbucket for the build status
[10:46:21.308] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:21.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:171:0) after 1m0s
[10:47:21.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:171:0)
[10:47:21.365] Timer tick, asking Buildbucket for the build status
[10:47:21.627] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:21.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:172:0) after 1m0s
[10:48:21.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:172:0)
[10:48:21.719] Timer tick, asking Buildbucket for the build status
[10:48:21.975] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:21.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:173:0) after 1m0s
[10:49:22.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:173:0)
[10:49:22.044] Timer tick, asking Buildbucket for the build status
[10:49:22.457] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:22.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:174:0) after 1m0s
[10:50:22.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:174:0)
[10:50:22.523] Timer tick, asking Buildbucket for the build status
[10:50:22.692] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:22.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:175:0) after 1m0s
[10:51:22.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:175:0)
[10:51:22.738] Timer tick, asking Buildbucket for the build status
[10:51:22.953] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:22.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:176:0) after 1m0s
[10:52:22.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:176:0)
[10:52:22.982] Timer tick, asking Buildbucket for the build status
[10:52:23.396] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:23.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:177:0) after 1m0s
[10:53:23.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:177:0)
[10:53:23.462] Timer tick, asking Buildbucket for the build status
[10:53:23.816] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:23.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:178:0) after 1m0s
[10:54:23.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:178:0)
[10:54:23.848] Timer tick, asking Buildbucket for the build status
[10:54:24.193] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:24.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:179:0) after 1m0s
[10:55:24.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:179:0)
[10:55:24.228] Timer tick, asking Buildbucket for the build status
[10:55:24.499] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:24.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:180:0) after 1m0s
[10:56:24.682] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:180:0)
[10:56:24.682] Timer tick, asking Buildbucket for the build status
[10:56:24.888] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:24.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:181:0) after 1m0s
[10:57:24.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:181:0)
[10:57:24.975] Timer tick, asking Buildbucket for the build status
[10:57:25.169] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:25.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:182:0) after 1m0s
[10:58:25.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:182:0)
[10:58:25.265] Timer tick, asking Buildbucket for the build status
[10:58:25.481] Build 8874815484513482272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:25.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040245546733432832:183:0) after 1m0s
[10:59:00.663] Received PubSub notification, asking Buildbucket for the build status
[10:59:00.753] Build 8874815484513482272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:59:00.753] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1594724339666144",
    "created_by": "project:infra",
    "created_ts": "1594713431783162",
    "id": "8874815484513482272",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4202.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e5ac5cce-1790-43ee-afba-af8bc1347d1f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4202.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-akz6\"], \"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.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5378-e275056\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1594713437181752",
    "status": "COMPLETED",
    "status_changed_ts": "1594724340287871",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040245546733432832",
      "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/8874815484513482272/+/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:4d652571e8769c10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1594724340330319",
    "url": "https://ci.chromium.org/b/8874815484513482272",
    "utcnow_ts": "1594724340741443"
  }
}
[10:59:00.753] Invocation finished in 3h1m50.471512748s with status SUCCEEDED