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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:02:12.536] New invocation is queued and will start shortly
[08:02:12.536] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:02:14.758] Starting the invocation (attempt 1)
[08:02:14.812] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:02:14.812] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:02:14.813] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9050210896149869712",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4096.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"b9f2c034-005f-462f-b4b1-6900a2e59bc1\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4096.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:9050210896149869712",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:02:15.429] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1585209734920264",
    "id": "8884780832954350496",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b9f2c034-005f-462f-b4b1-6900a2e59bc1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4096.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1585209735180271",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050210896149869712",
      "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/8884780832954350496/+/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": "1585209735180432",
    "url": "https://ci.chromium.org/b/8884780832954350496",
    "utcnow_ts": "1585209735406992"
  }
}
[08:02:15.429] Task URL: https://ci.chromium.org/b/8884780832954350496
[08:02:15.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:2:0) after 1m0s
[08:02:25.077] Received PubSub notification, asking Buildbucket for the build status
[08:02:27.158] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:15.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:2:0)
[08:03:15.537] Timer tick, asking Buildbucket for the build status
[08:03:15.700] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:15.700] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:4:0) after 1m0s
[08:04:15.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:4:0)
[08:04:15.875] Timer tick, asking Buildbucket for the build status
[08:04:16.007] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:16.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:5:0) after 1m0s
[08:05:16.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:5:0)
[08:05:16.245] Timer tick, asking Buildbucket for the build status
[08:05:16.416] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:16.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:6:0) after 1m0s
[08:06:16.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:6:0)
[08:06:16.471] Timer tick, asking Buildbucket for the build status
[08:06:16.625] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:16.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:7:0) after 1m0s
[08:07:16.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:7:0)
[08:07:16.679] Timer tick, asking Buildbucket for the build status
[08:07:16.804] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:16.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:8:0) after 1m0s
[08:08:16.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:8:0)
[08:08:16.829] Timer tick, asking Buildbucket for the build status
[08:08:16.963] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:16.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:9:0) after 1m0s
[08:09:17.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:9:0)
[08:09:17.041] Timer tick, asking Buildbucket for the build status
[08:09:17.163] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:17.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:10:0) after 1m0s
[08:10:17.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:10:0)
[08:10:17.233] Timer tick, asking Buildbucket for the build status
[08:10:17.394] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:17.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:11:0) after 1m0s
[08:11:17.429] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:11:0)
[08:11:17.429] Timer tick, asking Buildbucket for the build status
[08:11:17.787] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:17.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:12:0) after 1m0s
[08:12:17.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:12:0)
[08:12:17.910] Timer tick, asking Buildbucket for the build status
[08:12:18.063] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:18.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:13:0) after 1m0s
[08:13:18.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:13:0)
[08:13:18.145] Timer tick, asking Buildbucket for the build status
[08:13:18.293] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:18.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:14:0) after 1m0s
[08:14:18.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:14:0)
[08:14:18.331] Timer tick, asking Buildbucket for the build status
[08:14:18.451] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:18.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:15:0) after 1m0s
[08:15:18.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:15:0)
[08:15:18.500] Timer tick, asking Buildbucket for the build status
[08:15:18.638] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:18.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:16:0) after 1m0s
[08:16:18.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:16:0)
[08:16:18.752] Timer tick, asking Buildbucket for the build status
[08:16:19.134] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:19.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:17:0) after 1m0s
[08:17:19.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:17:0)
[08:17:19.195] Timer tick, asking Buildbucket for the build status
[08:17:19.456] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:19.456] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:18:0) after 1m0s
[08:18:19.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:18:0)
[08:18:19.450] Timer tick, asking Buildbucket for the build status
[08:18:19.559] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:19.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:19:0) after 1m0s
[08:19:19.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:19:0)
[08:19:19.587] Timer tick, asking Buildbucket for the build status
[08:19:19.879] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:19.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:20:0) after 1m0s
[08:20:19.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:20:0)
[08:20:19.934] Timer tick, asking Buildbucket for the build status
[08:20:20.328] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:20.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:21:0) after 1m0s
[08:21:20.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:21:0)
[08:21:20.369] Timer tick, asking Buildbucket for the build status
[08:21:20.512] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:20.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:22:0) after 1m0s
[08:22:20.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:22:0)
[08:22:20.533] Timer tick, asking Buildbucket for the build status
[08:22:20.807] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:20.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:23:0) after 1m0s
[08:23:20.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:23:0)
[08:23:20.857] Timer tick, asking Buildbucket for the build status
[08:23:21.242] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:21.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:24:0) after 1m0s
[08:24:21.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:24:0)
[08:24:21.235] Timer tick, asking Buildbucket for the build status
[08:24:21.373] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:21.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:25:0) after 1m0s
[08:25:21.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:25:0)
[08:25:21.454] Timer tick, asking Buildbucket for the build status
[08:25:21.590] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:21.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:26:0) after 1m0s
[08:26:21.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:26:0)
[08:26:21.616] Timer tick, asking Buildbucket for the build status
[08:26:21.750] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:21.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:27:0) after 1m0s
[08:27:21.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:27:0)
[08:27:21.773] Timer tick, asking Buildbucket for the build status
[08:27:22.113] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:22.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:28:0) after 1m0s
[08:28:22.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:28:0)
[08:28:22.184] Timer tick, asking Buildbucket for the build status
[08:28:22.326] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:22.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:29:0) after 1m0s
[08:29:22.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:29:0)
[08:29:22.425] Timer tick, asking Buildbucket for the build status
[08:29:22.626] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:22.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:30:0) after 1m0s
[08:30:22.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:30:0)
[08:30:22.657] Timer tick, asking Buildbucket for the build status
[08:30:22.957] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:22.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:31:0) after 1m0s
[08:31:22.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:31:0)
[08:31:22.996] Timer tick, asking Buildbucket for the build status
[08:31:23.196] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:23.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:32:0) after 1m0s
[08:32:23.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:32:0)
[08:32:23.238] Timer tick, asking Buildbucket for the build status
[08:32:23.693] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:23.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:33:0) after 1m0s
[08:33:23.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:33:0)
[08:33:23.766] Timer tick, asking Buildbucket for the build status
[08:33:23.887] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:23.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:34:0) after 1m0s
[08:34:23.944] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:34:0)
[08:34:23.944] Timer tick, asking Buildbucket for the build status
[08:34:24.080] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:24.080] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:35:0) after 1m0s
[08:35:24.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:35:0)
[08:35:24.164] Timer tick, asking Buildbucket for the build status
[08:35:24.296] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:24.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:36:0) after 1m0s
[08:36:24.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:36:0)
[08:36:24.332] Timer tick, asking Buildbucket for the build status
[08:36:24.690] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:24.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:37:0) after 1m0s
[08:37:24.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:37:0)
[08:37:24.711] Timer tick, asking Buildbucket for the build status
[08:37:24.822] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:24.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:38:0) after 1m0s
[08:38:24.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:38:0)
[08:38:24.819] Timer tick, asking Buildbucket for the build status
[08:38:25.075] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:25.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:39:0) after 1m0s
[08:39:25.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:39:0)
[08:39:25.169] Timer tick, asking Buildbucket for the build status
[08:39:25.346] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:25.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:40:0) after 1m0s
[08:40:25.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:40:0)
[08:40:25.366] Timer tick, asking Buildbucket for the build status
[08:40:25.465] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:25.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:41:0) after 1m0s
[08:41:25.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:41:0)
[08:41:25.494] Timer tick, asking Buildbucket for the build status
[08:41:25.832] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:25.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:42:0) after 1m0s
[08:42:25.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:42:0)
[08:42:25.852] Timer tick, asking Buildbucket for the build status
[08:42:26.341] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:26.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:43:0) after 1m0s
[08:43:26.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:43:0)
[08:43:26.417] Timer tick, asking Buildbucket for the build status
[08:43:26.917] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:26.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:44:0) after 1m0s
[08:44:27.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:44:0)
[08:44:27.014] Timer tick, asking Buildbucket for the build status
[08:44:27.115] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:27.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:45:0) after 1m0s
[08:45:27.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:45:0)
[08:45:27.153] Timer tick, asking Buildbucket for the build status
[08:45:27.263] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:27.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:46:0) after 1m0s
[08:46:27.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:46:0)
[08:46:27.285] Timer tick, asking Buildbucket for the build status
[08:46:27.406] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:27.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:47:0) after 1m0s
[08:47:27.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:47:0)
[08:47:27.469] Timer tick, asking Buildbucket for the build status
[08:47:27.699] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:27.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:48:0) after 1m0s
[08:48:27.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:48:0)
[08:48:27.739] Timer tick, asking Buildbucket for the build status
[08:48:28.186] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:28.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:49:0) after 1m0s
[08:49:28.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:49:0)
[08:49:28.223] Timer tick, asking Buildbucket for the build status
[08:49:28.376] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:28.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:50:0) after 1m0s
[08:50:28.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:50:0)
[08:50:28.420] Timer tick, asking Buildbucket for the build status
[08:50:28.529] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:28.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:51:0) after 1m0s
[08:51:28.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:51:0)
[08:51:28.548] Timer tick, asking Buildbucket for the build status
[08:51:28.690] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:28.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:52:0) after 1m0s
[08:52:28.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:52:0)
[08:52:28.715] Timer tick, asking Buildbucket for the build status
[08:52:28.868] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:28.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:53:0) after 1m0s
[08:53:28.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:53:0)
[08:53:28.904] Timer tick, asking Buildbucket for the build status
[08:53:29.888] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:29.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:54:0) after 1m0s
[08:54:30.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:54:0)
[08:54:30.046] Timer tick, asking Buildbucket for the build status
[08:54:30.178] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:30.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:55:0) after 1m0s
[08:55:30.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:55:0)
[08:55:30.248] Timer tick, asking Buildbucket for the build status
[08:55:30.407] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:30.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:56:0) after 1m0s
[08:56:30.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:56:0)
[08:56:30.461] Timer tick, asking Buildbucket for the build status
[08:56:30.599] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:30.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:57:0) after 1m0s
[08:57:30.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:57:0)
[08:57:30.628] Timer tick, asking Buildbucket for the build status
[08:57:30.764] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:30.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:58:0) after 1m0s
[08:58:30.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:58:0)
[08:58:30.788] Timer tick, asking Buildbucket for the build status
[08:58:30.964] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:30.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:59:0) after 1m0s
[08:59:31.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:59:0)
[08:59:31.087] Timer tick, asking Buildbucket for the build status
[08:59:31.222] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:31.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:60:0) after 1m0s
[09:00:31.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:60:0)
[09:00:31.311] Timer tick, asking Buildbucket for the build status
[09:00:31.576] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:31.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:61:0) after 1m0s
[09:01:31.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:61:0)
[09:01:31.627] Timer tick, asking Buildbucket for the build status
[09:01:31.737] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:31.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:62:0) after 1m0s
[09:02:31.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:62:0)
[09:02:31.877] Timer tick, asking Buildbucket for the build status
[09:02:32.058] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:32.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:63:0) after 1m0s
[09:03:32.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:63:0)
[09:03:32.181] Timer tick, asking Buildbucket for the build status
[09:03:32.349] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:32.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:64:0) after 1m0s
[09:04:32.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:64:0)
[09:04:32.527] Timer tick, asking Buildbucket for the build status
[09:04:32.864] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:32.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:65:0) after 1m0s
[09:05:32.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:65:0)
[09:05:32.893] Timer tick, asking Buildbucket for the build status
[09:05:33.348] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:33.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:66:0) after 1m0s
[09:06:33.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:66:0)
[09:06:33.362] Timer tick, asking Buildbucket for the build status
[09:06:33.490] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:33.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:67:0) after 1m0s
[09:07:33.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:67:0)
[09:07:33.511] Timer tick, asking Buildbucket for the build status
[09:07:33.973] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:33.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:68:0) after 1m0s
[09:08:34.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:68:0)
[09:08:34.112] Timer tick, asking Buildbucket for the build status
[09:08:34.747] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:34.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:69:0) after 1m0s
[09:09:34.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:69:0)
[09:09:34.770] Timer tick, asking Buildbucket for the build status
[09:09:35.130] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:35.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:70:0) after 1m0s
[09:10:35.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:70:0)
[09:10:35.440] Timer tick, asking Buildbucket for the build status
[09:10:35.587] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:35.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:71:0) after 1m0s
[09:11:35.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:71:0)
[09:11:35.783] Timer tick, asking Buildbucket for the build status
[09:11:35.983] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:35.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:72:0) after 1m0s
[09:12:36.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:72:0)
[09:12:36.004] Timer tick, asking Buildbucket for the build status
[09:12:36.153] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:36.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:73:0) after 1m0s
[09:13:36.378] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:73:0)
[09:13:36.378] Timer tick, asking Buildbucket for the build status
[09:13:37.887] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:37.887] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:74:0) after 1m0s
[09:14:38.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:74:0)
[09:14:38.082] Timer tick, asking Buildbucket for the build status
[09:14:38.274] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:38.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:75:0) after 1m0s
[09:15:38.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:75:0)
[09:15:38.416] Timer tick, asking Buildbucket for the build status
[09:15:38.566] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:38.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:76:0) after 1m0s
[09:16:38.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:76:0)
[09:16:38.684] Timer tick, asking Buildbucket for the build status
[09:16:38.860] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:38.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:77:0) after 1m0s
[09:17:38.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:77:0)
[09:17:38.895] Timer tick, asking Buildbucket for the build status
[09:17:39.040] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:39.040] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:78:0) after 1m0s
[09:18:39.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:78:0)
[09:18:39.109] Timer tick, asking Buildbucket for the build status
[09:18:39.922] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:39.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:79:0) after 1m0s
[09:19:39.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:79:0)
[09:19:39.996] Timer tick, asking Buildbucket for the build status
[09:19:40.230] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:40.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:80:0) after 1m0s
[09:20:40.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:80:0)
[09:20:40.326] Timer tick, asking Buildbucket for the build status
[09:20:40.849] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:40.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:81:0) after 1m0s
[09:21:40.872] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:81:0)
[09:21:40.872] Timer tick, asking Buildbucket for the build status
[09:21:41.217] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:41.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:82:0) after 1m0s
[09:22:41.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:82:0)
[09:22:41.202] Timer tick, asking Buildbucket for the build status
[09:22:41.400] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:41.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:83:0) after 1m0s
[09:23:41.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:83:0)
[09:23:41.420] Timer tick, asking Buildbucket for the build status
[09:23:42.551] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:42.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:84:0) after 1m0s
[09:24:42.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:84:0)
[09:24:42.575] Timer tick, asking Buildbucket for the build status
[09:24:42.665] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:42.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:85:0) after 1m0s
[09:25:42.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:85:0)
[09:25:42.741] Timer tick, asking Buildbucket for the build status
[09:25:42.905] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:42.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:86:0) after 1m0s
[09:26:42.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:86:0)
[09:26:42.983] Timer tick, asking Buildbucket for the build status
[09:26:43.051] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:43.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:87:0) after 1m0s
[09:27:43.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:87:0)
[09:27:43.076] Timer tick, asking Buildbucket for the build status
[09:27:43.347] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:43.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:88:0) after 1m0s
[09:28:43.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:88:0)
[09:28:43.440] Timer tick, asking Buildbucket for the build status
[09:28:44.354] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:44.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:89:0) after 1m0s
[09:29:44.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:89:0)
[09:29:44.425] Timer tick, asking Buildbucket for the build status
[09:29:44.559] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:44.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:90:0) after 1m0s
[09:30:44.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:90:0)
[09:30:44.695] Timer tick, asking Buildbucket for the build status
[09:30:44.875] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:44.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:91:0) after 1m0s
[09:31:44.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:91:0)
[09:31:44.920] Timer tick, asking Buildbucket for the build status
[09:31:45.049] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:45.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:92:0) after 1m0s
[09:32:45.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:92:0)
[09:32:45.232] Timer tick, asking Buildbucket for the build status
[09:32:45.443] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:45.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:93:0) after 1m0s
[09:33:45.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:93:0)
[09:33:45.539] Timer tick, asking Buildbucket for the build status
[09:33:46.318] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:46.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:94:0) after 1m0s
[09:34:46.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:94:0)
[09:34:46.351] Timer tick, asking Buildbucket for the build status
[09:34:46.733] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:46.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:95:0) after 1m0s
[09:35:46.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:95:0)
[09:35:46.853] Timer tick, asking Buildbucket for the build status
[09:35:46.958] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:46.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:96:0) after 1m0s
[09:36:47.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:96:0)
[09:36:47.021] Timer tick, asking Buildbucket for the build status
[09:36:47.329] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:47.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:97:0) after 1m0s
[09:37:47.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:97:0)
[09:37:47.354] Timer tick, asking Buildbucket for the build status
[09:37:47.509] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:47.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:98:0) after 1m0s
[09:38:47.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:98:0)
[09:38:47.538] Timer tick, asking Buildbucket for the build status
[09:38:47.645] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:47.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:99:0) after 1m0s
[09:39:47.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:99:0)
[09:39:47.634] Timer tick, asking Buildbucket for the build status
[09:39:47.798] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:47.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:100:0) after 1m0s
[09:40:48.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:100:0)
[09:40:48.265] Timer tick, asking Buildbucket for the build status
[09:40:48.390] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:48.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:101:0) after 1m0s
[09:41:48.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:101:0)
[09:41:48.408] Timer tick, asking Buildbucket for the build status
[09:41:48.506] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:48.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:102:0) after 1m0s
[09:42:48.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:102:0)
[09:42:48.585] Timer tick, asking Buildbucket for the build status
[09:42:48.781] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:48.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:103:0) after 1m0s
[09:43:48.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:103:0)
[09:43:48.833] Timer tick, asking Buildbucket for the build status
[09:43:51.530] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:51.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:104:0) after 1m0s
[09:44:51.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:104:0)
[09:44:51.764] Timer tick, asking Buildbucket for the build status
[09:44:51.936] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:51.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:105:0) after 1m0s
[09:45:52.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:105:0)
[09:45:52.048] Timer tick, asking Buildbucket for the build status
[09:45:52.295] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:52.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:106:0) after 1m0s
[09:46:52.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:106:0)
[09:46:52.361] Timer tick, asking Buildbucket for the build status
[09:46:52.486] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:52.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:107:0) after 1m0s
[09:47:52.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:107:0)
[09:47:52.629] Timer tick, asking Buildbucket for the build status
[09:47:53.240] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:53.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:108:0) after 1m0s
[09:48:53.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:108:0)
[09:48:53.407] Timer tick, asking Buildbucket for the build status
[09:48:53.681] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:53.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:109:0) after 1m0s
[09:49:53.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:109:0)
[09:49:53.758] Timer tick, asking Buildbucket for the build status
[09:49:54.860] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:54.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:110:0) after 1m0s
[09:50:54.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:110:0)
[09:50:54.997] Timer tick, asking Buildbucket for the build status
[09:50:55.133] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:55.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:111:0) after 1m0s
[09:51:55.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:111:0)
[09:51:55.214] Timer tick, asking Buildbucket for the build status
[09:51:55.277] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:55.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:112:0) after 1m0s
[09:52:55.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:112:0)
[09:52:55.309] Timer tick, asking Buildbucket for the build status
[09:52:55.404] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:55.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:113:0) after 1m0s
[09:53:55.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:113:0)
[09:53:55.590] Timer tick, asking Buildbucket for the build status
[09:53:55.704] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:55.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:114:0) after 1m0s
[09:54:55.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:114:0)
[09:54:55.745] Timer tick, asking Buildbucket for the build status
[09:54:55.892] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:55.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:115:0) after 1m0s
[09:55:56.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:115:0)
[09:55:56.358] Timer tick, asking Buildbucket for the build status
[09:55:56.563] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:56.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:116:0) after 1m0s
[09:56:56.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:116:0)
[09:56:56.601] Timer tick, asking Buildbucket for the build status
[09:56:56.888] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:56.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:117:0) after 1m0s
[09:57:56.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:117:0)
[09:57:56.999] Timer tick, asking Buildbucket for the build status
[09:57:57.298] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:57.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:118:0) after 1m0s
[09:58:57.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:118:0)
[09:58:57.334] Timer tick, asking Buildbucket for the build status
[09:58:57.475] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:57.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:119:0) after 1m0s
[09:59:57.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:119:0)
[09:59:57.564] Timer tick, asking Buildbucket for the build status
[09:59:57.905] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:57.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:120:0) after 1m0s
[10:00:58.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:120:0)
[10:00:58.061] Timer tick, asking Buildbucket for the build status
[10:00:58.180] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:58.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:121:0) after 1m0s
[10:01:58.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:121:0)
[10:01:58.313] Timer tick, asking Buildbucket for the build status
[10:01:58.408] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:58.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:122:0) after 1m0s
[10:02:58.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:122:0)
[10:02:58.542] Timer tick, asking Buildbucket for the build status
[10:02:58.691] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:58.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:123:0) after 1m0s
[10:03:58.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:123:0)
[10:03:58.798] Timer tick, asking Buildbucket for the build status
[10:03:59.075] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:59.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:124:0) after 1m0s
[10:04:59.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:124:0)
[10:04:59.247] Timer tick, asking Buildbucket for the build status
[10:04:59.370] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:59.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:125:0) after 1m0s
[10:05:59.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:125:0)
[10:05:59.433] Timer tick, asking Buildbucket for the build status
[10:05:59.611] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:59.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:126:0) after 1m0s
[10:06:59.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:126:0)
[10:06:59.797] Timer tick, asking Buildbucket for the build status
[10:07:00.025] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:00.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:127:0) after 1m0s
[10:08:00.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:127:0)
[10:08:00.055] Timer tick, asking Buildbucket for the build status
[10:08:00.478] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:00.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:128:0) after 1m0s
[10:09:00.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:128:0)
[10:09:00.525] Timer tick, asking Buildbucket for the build status
[10:09:00.728] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:00.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:129:0) after 1m0s
[10:10:00.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:129:0)
[10:10:00.762] Timer tick, asking Buildbucket for the build status
[10:10:00.921] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:00.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:130:0) after 1m0s
[10:11:01.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:130:0)
[10:11:01.218] Timer tick, asking Buildbucket for the build status
[10:11:01.359] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:01.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:131:0) after 1m0s
[10:12:01.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:131:0)
[10:12:01.424] Timer tick, asking Buildbucket for the build status
[10:12:01.610] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:01.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:132:0) after 1m0s
[10:13:01.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:132:0)
[10:13:01.743] Timer tick, asking Buildbucket for the build status
[10:13:01.863] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:01.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:133:0) after 1m0s
[10:14:02.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:133:0)
[10:14:02.032] Timer tick, asking Buildbucket for the build status
[10:14:02.112] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:02.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:134:0) after 1m0s
[10:15:02.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:134:0)
[10:15:02.344] Timer tick, asking Buildbucket for the build status
[10:15:02.461] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:02.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:135:0) after 1m0s
[10:16:02.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:135:0)
[10:16:02.805] Timer tick, asking Buildbucket for the build status
[10:16:02.942] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:02.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:136:0) after 1m0s
[10:17:03.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:136:0)
[10:17:03.099] Timer tick, asking Buildbucket for the build status
[10:17:03.499] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:03.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:137:0) after 1m0s
[10:18:03.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:137:0)
[10:18:03.769] Timer tick, asking Buildbucket for the build status
[10:18:03.902] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:03.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:138:0) after 1m0s
[10:19:04.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:138:0)
[10:19:04.081] Timer tick, asking Buildbucket for the build status
[10:19:04.354] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:04.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:139:0) after 1m0s
[10:20:04.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:139:0)
[10:20:04.510] Timer tick, asking Buildbucket for the build status
[10:20:05.933] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:05.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:140:0) after 1m0s
[10:21:06.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:140:0)
[10:21:06.208] Timer tick, asking Buildbucket for the build status
[10:21:06.312] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:06.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:141:0) after 1m0s
[10:22:06.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:141:0)
[10:22:06.507] Timer tick, asking Buildbucket for the build status
[10:22:06.596] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:06.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:142:0) after 1m0s
[10:23:06.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:142:0)
[10:23:06.748] Timer tick, asking Buildbucket for the build status
[10:23:06.952] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:06.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:143:0) after 1m0s
[10:24:07.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:143:0)
[10:24:07.212] Timer tick, asking Buildbucket for the build status
[10:24:07.621] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:07.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:144:0) after 1m0s
[10:25:07.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:144:0)
[10:25:07.673] Timer tick, asking Buildbucket for the build status
[10:25:07.799] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:07.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:145:0) after 1m0s
[10:26:07.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:145:0)
[10:26:07.871] Timer tick, asking Buildbucket for the build status
[10:26:07.980] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:07.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:146:0) after 1m0s
[10:27:08.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:146:0)
[10:27:08.228] Timer tick, asking Buildbucket for the build status
[10:27:08.554] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:08.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:147:0) after 1m0s
[10:28:08.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:147:0)
[10:28:08.639] Timer tick, asking Buildbucket for the build status
[10:28:08.832] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:08.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:148:0) after 1m0s
[10:29:08.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:148:0)
[10:29:08.901] Timer tick, asking Buildbucket for the build status
[10:29:08.975] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:08.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:149:0) after 1m0s
[10:30:09.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:149:0)
[10:30:09.022] Timer tick, asking Buildbucket for the build status
[10:30:09.219] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:09.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:150:0) after 1m0s
[10:31:09.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:150:0)
[10:31:09.255] Timer tick, asking Buildbucket for the build status
[10:31:09.454] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:09.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:151:0) after 1m0s
[10:32:09.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:151:0)
[10:32:09.588] Timer tick, asking Buildbucket for the build status
[10:32:09.807] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:09.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:152:0) after 1m0s
[10:33:09.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:152:0)
[10:33:09.867] Timer tick, asking Buildbucket for the build status
[10:33:09.992] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:09.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:153:0) after 1m0s
[10:34:10.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:153:0)
[10:34:10.039] Timer tick, asking Buildbucket for the build status
[10:34:10.209] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:10.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:154:0) after 1m0s
[10:35:10.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:154:0)
[10:35:10.271] Timer tick, asking Buildbucket for the build status
[10:35:10.388] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:10.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:155:0) after 1m0s
[10:36:10.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:155:0)
[10:36:10.446] Timer tick, asking Buildbucket for the build status
[10:36:10.506] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:10.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:156:0) after 1m0s
[10:37:10.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:156:0)
[10:37:10.555] Timer tick, asking Buildbucket for the build status
[10:37:10.785] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:10.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:157:0) after 1m0s
[10:38:10.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:157:0)
[10:38:10.863] Timer tick, asking Buildbucket for the build status
[10:38:11.135] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:11.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:158:0) after 1m0s
[10:39:11.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:158:0)
[10:39:11.159] Timer tick, asking Buildbucket for the build status
[10:39:11.302] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:11.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:159:0) after 1m0s
[10:40:11.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:159:0)
[10:40:11.316] Timer tick, asking Buildbucket for the build status
[10:40:11.525] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:11.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:160:0) after 1m0s
[10:41:11.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:160:0)
[10:41:11.549] Timer tick, asking Buildbucket for the build status
[10:41:11.741] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:11.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:161:0) after 1m0s
[10:42:11.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:161:0)
[10:42:11.773] Timer tick, asking Buildbucket for the build status
[10:42:12.038] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:12.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:162:0) after 1m0s
[10:43:12.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:162:0)
[10:43:12.049] Timer tick, asking Buildbucket for the build status
[10:43:12.139] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:12.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:163:0) after 1m0s
[10:44:12.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:163:0)
[10:44:12.155] Timer tick, asking Buildbucket for the build status
[10:44:12.294] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:12.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:164:0) after 1m0s
[10:45:12.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:164:0)
[10:45:12.357] Timer tick, asking Buildbucket for the build status
[10:45:12.477] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:12.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:165:0) after 1m0s
[10:46:12.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:165:0)
[10:46:12.498] Timer tick, asking Buildbucket for the build status
[10:46:12.602] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:12.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:166:0) after 1m0s
[10:47:12.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:166:0)
[10:47:12.633] Timer tick, asking Buildbucket for the build status
[10:47:12.769] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:12.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:167:0) after 1m0s
[10:48:12.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:167:0)
[10:48:12.803] Timer tick, asking Buildbucket for the build status
[10:48:12.922] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:12.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:168:0) after 1m0s
[10:49:12.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:168:0)
[10:49:12.950] Timer tick, asking Buildbucket for the build status
[10:49:13.142] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:13.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:169:0) after 1m0s
[10:50:13.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:169:0)
[10:50:13.137] Timer tick, asking Buildbucket for the build status
[10:50:13.229] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:13.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:170:0) after 1m0s
[10:51:13.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:170:0)
[10:51:13.268] Timer tick, asking Buildbucket for the build status
[10:51:13.386] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:13.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:171:0) after 1m0s
[10:52:13.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:171:0)
[10:52:13.414] Timer tick, asking Buildbucket for the build status
[10:52:13.524] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:13.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:172:0) after 1m0s
[10:53:13.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:172:0)
[10:53:13.571] Timer tick, asking Buildbucket for the build status
[10:53:13.777] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:13.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:173:0) after 1m0s
[10:54:13.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:173:0)
[10:54:13.806] Timer tick, asking Buildbucket for the build status
[10:54:14.127] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:14.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:174:0) after 1m0s
[10:55:14.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:174:0)
[10:55:14.238] Timer tick, asking Buildbucket for the build status
[10:55:14.399] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:14.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:175:0) after 1m0s
[10:56:14.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:175:0)
[10:56:14.452] Timer tick, asking Buildbucket for the build status
[10:56:14.545] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:14.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:176:0) after 1m0s
[10:57:14.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:176:0)
[10:57:14.564] Timer tick, asking Buildbucket for the build status
[10:57:14.658] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:14.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:177:0) after 1m0s
[10:58:14.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:177:0)
[10:58:14.736] Timer tick, asking Buildbucket for the build status
[10:58:16.392] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:16.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:178:0) after 1m0s
[10:59:16.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:178:0)
[10:59:16.454] Timer tick, asking Buildbucket for the build status
[10:59:16.988] Build 8884780832954350496: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:16.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9050210896149869712:179:0) after 1m0s
[10:59:27.221] Received PubSub notification, asking Buildbucket for the build status
[10:59:27.775] Build 8884780832954350496: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:59:27.775] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1585220365077477",
    "created_by": "project:infra",
    "created_ts": "1585209734920264",
    "id": "8884780832954350496",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b9f2c034-005f-462f-b4b1-6900a2e59bc1\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4096.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4096.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b9f2c034-005f-462f-b4b1-6900a2e59bc1\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-o59j\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4096.0\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"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-o59j\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"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\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1585209743480485",
    "status": "COMPLETED",
    "status_changed_ts": "1585220365788453",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9050210896149869712",
      "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/8884780832954350496/+/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:4b2eae84b4bbd810",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1585220365808909",
    "url": "https://ci.chromium.org/b/8884780832954350496",
    "utcnow_ts": "1585220367764169"
  }
}
[10:59:27.775] Invocation finished in 2h57m15.286376159s with status SUCCEEDED