Status: FAILED
Triggered by: chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
Duration: 3 hours
Actions:

Definition (rev d0acf8648771c75c4d75c08daf9c0088a362343f)

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

Incoming triggers

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

Incoming properties

{
  "version": "72.0.3595.2"
}

Incoming tags

  • parent_buildername:publish_tarball
  • user_agent:recipe

Debug log (UTC)

[04:33:12.519] New invocation is queued and will start shortly
[04:33:12.519] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[04:33:13.762] Starting the invocation (attempt 1)
[04:33:13.795] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:33:13.795] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:33:13.795] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9096700289052449296",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"72.0.3595.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9096700289052449296",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[04:33:15.365] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1540873993864903",
    "id": "8931270226968787648",
    "lease_expiration_ts": "1540992795234186",
    "lease_key": "1612882351",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3595.2\"}}",
    "project": "infra",
    "result_details_json": "null",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1540873995236917",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096700289052449296",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:infra/cron",
      "swarming_tag:buildbucket_build_id:8931270226968787648",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8931270226968787648/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:parent_buildername:publish_tarball",
      "swarming_tag:pool:luci.infra.cron",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_tag:scheduler_invocation_id:9096700289052449296",
      "swarming_tag:scheduler_job_id:infra/Build From Tarball",
      "swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7e0a382bd146d54a2b93225115f789f999b027c1",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40dc10ca7bf85110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1540873995237083",
    "url": "https://ci.chromium.org/b/8931270226968787648",
    "utcnow_ts": "1540873995355453"
  }
}
[04:33:15.365] Task URL: https://ci.chromium.org/b/8931270226968787648
[04:33:15.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:2:0) after 1m0s
[04:34:15.263] Received PubSub notification, asking Buildbucket for the build status
[04:34:15.309] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:15.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:2:0)
[04:34:15.463] Timer tick, asking Buildbucket for the build status
[04:34:15.578] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:15.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:4:0) after 1m0s
[04:35:15.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:4:0)
[04:35:15.600] Timer tick, asking Buildbucket for the build status
[04:35:15.642] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:15.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:5:0) after 1m0s
[04:36:15.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:5:0)
[04:36:15.665] Timer tick, asking Buildbucket for the build status
[04:36:15.743] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:15.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:6:0) after 1m0s
[04:37:15.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:6:0)
[04:37:15.766] Timer tick, asking Buildbucket for the build status
[04:37:15.826] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:15.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:7:0) after 1m0s
[04:38:15.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:7:0)
[04:38:15.878] Timer tick, asking Buildbucket for the build status
[04:38:15.916] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:15.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:8:0) after 1m0s
[04:39:15.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:8:0)
[04:39:15.943] Timer tick, asking Buildbucket for the build status
[04:39:16.043] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:16.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:9:0) after 1m0s
[04:40:16.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:9:0)
[04:40:16.086] Timer tick, asking Buildbucket for the build status
[04:40:16.122] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:16.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:10:0) after 1m0s
[04:41:16.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:10:0)
[04:41:16.147] Timer tick, asking Buildbucket for the build status
[04:41:16.250] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:16.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:11:0) after 1m0s
[04:42:16.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:11:0)
[04:42:16.279] Timer tick, asking Buildbucket for the build status
[04:42:16.311] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:16.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:12:0) after 1m0s
[04:43:16.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:12:0)
[04:43:16.339] Timer tick, asking Buildbucket for the build status
[04:43:16.451] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:16.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:13:0) after 1m0s
[04:44:16.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:13:0)
[04:44:16.536] Timer tick, asking Buildbucket for the build status
[04:44:16.597] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:16.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:14:0) after 1m0s
[04:45:16.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:14:0)
[04:45:16.626] Timer tick, asking Buildbucket for the build status
[04:45:16.682] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:16.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:15:0) after 1m0s
[04:46:16.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:15:0)
[04:46:16.703] Timer tick, asking Buildbucket for the build status
[04:46:16.775] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:16.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:16:0) after 1m0s
[04:47:16.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:16:0)
[04:47:16.796] Timer tick, asking Buildbucket for the build status
[04:47:16.865] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:16.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:17:0) after 1m0s
[04:48:16.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:17:0)
[04:48:16.966] Timer tick, asking Buildbucket for the build status
[04:48:17.099] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:17.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:18:0) after 1m0s
[04:49:17.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:18:0)
[04:49:17.120] Timer tick, asking Buildbucket for the build status
[04:49:17.188] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:19:0) after 1m0s
[04:50:17.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:19:0)
[04:50:17.293] Timer tick, asking Buildbucket for the build status
[04:50:17.351] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:20:0) after 1m0s
[04:51:17.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:20:0)
[04:51:17.371] Timer tick, asking Buildbucket for the build status
[04:51:17.610] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:17.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:21:0) after 1m0s
[04:52:17.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:21:0)
[04:52:17.629] Timer tick, asking Buildbucket for the build status
[04:52:17.669] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:17.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:22:0) after 1m0s
[04:53:17.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:22:0)
[04:53:17.852] Timer tick, asking Buildbucket for the build status
[04:53:17.953] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:17.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:23:0) after 1m0s
[04:54:17.972] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:23:0)
[04:54:17.972] Timer tick, asking Buildbucket for the build status
[04:54:18.049] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:18.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:24:0) after 1m0s
[04:55:18.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:24:0)
[04:55:18.157] Timer tick, asking Buildbucket for the build status
[04:55:18.271] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:18.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:25:0) after 1m0s
[04:56:18.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:25:0)
[04:56:18.368] Timer tick, asking Buildbucket for the build status
[04:56:18.452] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:18.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:26:0) after 1m0s
[04:57:18.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:26:0)
[04:57:18.474] Timer tick, asking Buildbucket for the build status
[04:57:18.545] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:18.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:27:0) after 1m0s
[04:58:18.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:27:0)
[04:58:18.613] Timer tick, asking Buildbucket for the build status
[04:58:18.670] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:18.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:28:0) after 1m0s
[04:59:18.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:28:0)
[04:59:18.713] Timer tick, asking Buildbucket for the build status
[04:59:18.827] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:18.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:29:0) after 1m0s
[05:00:18.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:29:0)
[05:00:18.850] Timer tick, asking Buildbucket for the build status
[05:00:18.904] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:18.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:30:0) after 1m0s
[05:01:18.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:30:0)
[05:01:18.941] Timer tick, asking Buildbucket for the build status
[05:01:19.114] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:19.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:31:0) after 1m0s
[05:02:19.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:31:0)
[05:02:19.138] Timer tick, asking Buildbucket for the build status
[05:02:19.256] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:19.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:32:0) after 1m0s
[05:03:19.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:32:0)
[05:03:19.280] Timer tick, asking Buildbucket for the build status
[05:03:19.372] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:19.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:33:0) after 1m0s
[05:04:19.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:33:0)
[05:04:19.392] Timer tick, asking Buildbucket for the build status
[05:04:19.435] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:19.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:34:0) after 1m0s
[05:05:19.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:34:0)
[05:05:19.464] Timer tick, asking Buildbucket for the build status
[05:05:19.526] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:19.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:35:0) after 1m0s
[05:06:19.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:35:0)
[05:06:19.563] Timer tick, asking Buildbucket for the build status
[05:06:19.624] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:19.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:36:0) after 1m0s
[05:07:19.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:36:0)
[05:07:19.644] Timer tick, asking Buildbucket for the build status
[05:07:19.785] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:19.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:37:0) after 1m0s
[05:08:19.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:37:0)
[05:08:19.805] Timer tick, asking Buildbucket for the build status
[05:08:19.868] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:19.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:38:0) after 1m0s
[05:09:19.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:38:0)
[05:09:19.893] Timer tick, asking Buildbucket for the build status
[05:09:20.149] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:20.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:39:0) after 1m0s
[05:10:20.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:39:0)
[05:10:20.250] Timer tick, asking Buildbucket for the build status
[05:10:20.293] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:20.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:40:0) after 1m0s
[05:11:20.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:40:0)
[05:11:20.311] Timer tick, asking Buildbucket for the build status
[05:11:20.370] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:20.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:41:0) after 1m0s
[05:12:20.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:41:0)
[05:12:20.390] Timer tick, asking Buildbucket for the build status
[05:12:20.653] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:20.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:42:0) after 1m0s
[05:13:20.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:42:0)
[05:13:20.673] Timer tick, asking Buildbucket for the build status
[05:13:20.784] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:20.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:43:0) after 1m0s
[05:14:20.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:43:0)
[05:14:20.803] Timer tick, asking Buildbucket for the build status
[05:14:21.297] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:21.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:44:0) after 1m0s
[05:15:21.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:44:0)
[05:15:21.321] Timer tick, asking Buildbucket for the build status
[05:15:21.385] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:21.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:45:0) after 1m0s
[05:16:21.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:45:0)
[05:16:21.419] Timer tick, asking Buildbucket for the build status
[05:16:21.516] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:46:0) after 1m0s
[05:17:21.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:46:0)
[05:17:21.537] Timer tick, asking Buildbucket for the build status
[05:17:21.601] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:21.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:47:0) after 1m0s
[05:18:21.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:47:0)
[05:18:21.624] Timer tick, asking Buildbucket for the build status
[05:18:21.782] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:21.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:48:0) after 1m0s
[05:19:21.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:48:0)
[05:19:21.802] Timer tick, asking Buildbucket for the build status
[05:19:21.980] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:21.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:49:0) after 1m0s
[05:20:22.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:49:0)
[05:20:22.006] Timer tick, asking Buildbucket for the build status
[05:20:22.079] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:22.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:50:0) after 1m0s
[05:21:22.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:50:0)
[05:21:22.100] Timer tick, asking Buildbucket for the build status
[05:21:22.169] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:22.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:51:0) after 1m0s
[05:22:22.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:51:0)
[05:22:22.190] Timer tick, asking Buildbucket for the build status
[05:22:22.338] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:22.338] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:52:0) after 1m0s
[05:23:22.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:52:0)
[05:23:22.406] Timer tick, asking Buildbucket for the build status
[05:23:22.474] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:22.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:53:0) after 1m0s
[05:24:22.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:53:0)
[05:24:22.495] Timer tick, asking Buildbucket for the build status
[05:24:22.579] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:22.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:54:0) after 1m0s
[05:25:22.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:54:0)
[05:25:22.602] Timer tick, asking Buildbucket for the build status
[05:25:22.658] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:22.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:55:0) after 1m0s
[05:26:22.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:55:0)
[05:26:22.760] Timer tick, asking Buildbucket for the build status
[05:26:22.851] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:22.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:56:0) after 1m0s
[05:27:22.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:56:0)
[05:27:22.875] Timer tick, asking Buildbucket for the build status
[05:27:22.995] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:22.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:57:0) after 1m0s
[05:28:23.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:57:0)
[05:28:23.017] Timer tick, asking Buildbucket for the build status
[05:28:23.191] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:23.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:58:0) after 1m0s
[05:29:23.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:58:0)
[05:29:23.211] Timer tick, asking Buildbucket for the build status
[05:29:23.316] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:23.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:59:0) after 1m0s
[05:30:23.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:59:0)
[05:30:23.339] Timer tick, asking Buildbucket for the build status
[05:30:23.432] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:23.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:60:0) after 1m0s
[05:31:23.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:60:0)
[05:31:23.451] Timer tick, asking Buildbucket for the build status
[05:31:23.513] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:23.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:61:0) after 1m0s
[05:32:23.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:61:0)
[05:32:23.536] Timer tick, asking Buildbucket for the build status
[05:32:23.588] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:23.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:62:0) after 1m0s
[05:33:23.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:62:0)
[05:33:23.614] Timer tick, asking Buildbucket for the build status
[05:33:23.669] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:23.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:63:0) after 1m0s
[05:34:23.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:63:0)
[05:34:23.708] Timer tick, asking Buildbucket for the build status
[05:34:23.782] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:23.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:64:0) after 1m0s
[05:35:23.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:64:0)
[05:35:23.815] Timer tick, asking Buildbucket for the build status
[05:35:23.911] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:23.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:65:0) after 1m0s
[05:36:23.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:65:0)
[05:36:23.936] Timer tick, asking Buildbucket for the build status
[05:36:24.032] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:24.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:66:0) after 1m0s
[05:37:24.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:66:0)
[05:37:24.055] Timer tick, asking Buildbucket for the build status
[05:37:26.818] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:26.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:67:0) after 1m0s
[05:38:26.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:67:0)
[05:38:26.840] Timer tick, asking Buildbucket for the build status
[05:38:26.963] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:26.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:68:0) after 1m0s
[05:39:27.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:68:0)
[05:39:27.077] Timer tick, asking Buildbucket for the build status
[05:39:27.259] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:27.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:69:0) after 1m0s
[05:40:27.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:69:0)
[05:40:27.284] Timer tick, asking Buildbucket for the build status
[05:40:27.358] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:27.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:70:0) after 1m0s
[05:41:27.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:70:0)
[05:41:27.383] Timer tick, asking Buildbucket for the build status
[05:41:27.455] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:27.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:71:0) after 1m0s
[05:42:27.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:71:0)
[05:42:27.478] Timer tick, asking Buildbucket for the build status
[05:42:27.640] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:27.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:72:0) after 1m0s
[05:43:27.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:72:0)
[05:43:27.664] Timer tick, asking Buildbucket for the build status
[05:43:27.741] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:27.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:73:0) after 1m0s
[05:44:27.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:73:0)
[05:44:27.764] Timer tick, asking Buildbucket for the build status
[05:44:27.827] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:27.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:74:0) after 1m0s
[05:45:27.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:74:0)
[05:45:27.848] Timer tick, asking Buildbucket for the build status
[05:45:27.968] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:27.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:75:0) after 1m0s
[05:46:27.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:75:0)
[05:46:27.993] Timer tick, asking Buildbucket for the build status
[05:46:28.100] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:28.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:76:0) after 1m0s
[05:47:28.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:76:0)
[05:47:28.127] Timer tick, asking Buildbucket for the build status
[05:47:28.182] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:28.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:77:0) after 1m0s
[05:48:28.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:77:0)
[05:48:28.262] Timer tick, asking Buildbucket for the build status
[05:48:28.319] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:28.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:78:0) after 1m0s
[05:49:28.392] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:78:0)
[05:49:28.392] Timer tick, asking Buildbucket for the build status
[05:49:28.453] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:28.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:79:0) after 1m0s
[05:50:28.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:79:0)
[05:50:28.493] Timer tick, asking Buildbucket for the build status
[05:50:28.547] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:28.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:80:0) after 1m0s
[05:51:28.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:80:0)
[05:51:28.573] Timer tick, asking Buildbucket for the build status
[05:51:28.653] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:28.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:81:0) after 1m0s
[05:52:28.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:81:0)
[05:52:28.686] Timer tick, asking Buildbucket for the build status
[05:52:28.754] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:28.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:82:0) after 1m0s
[05:53:28.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:82:0)
[05:53:28.778] Timer tick, asking Buildbucket for the build status
[05:53:28.897] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:28.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:83:0) after 1m0s
[05:54:28.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:83:0)
[05:54:28.938] Timer tick, asking Buildbucket for the build status
[05:54:28.995] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:28.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:84:0) after 1m0s
[05:55:29.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:84:0)
[05:55:29.018] Timer tick, asking Buildbucket for the build status
[05:55:29.098] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:29.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:85:0) after 1m0s
[05:56:29.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:85:0)
[05:56:29.124] Timer tick, asking Buildbucket for the build status
[05:56:29.242] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:29.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:86:0) after 1m0s
[05:57:29.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:86:0)
[05:57:29.266] Timer tick, asking Buildbucket for the build status
[05:57:29.326] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:29.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:87:0) after 1m0s
[05:58:29.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:87:0)
[05:58:29.351] Timer tick, asking Buildbucket for the build status
[05:58:29.406] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:29.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:88:0) after 1m0s
[05:59:29.435] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:88:0)
[05:59:29.435] Timer tick, asking Buildbucket for the build status
[05:59:29.816] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:29.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:89:0) after 1m0s
[06:00:29.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:89:0)
[06:00:29.852] Timer tick, asking Buildbucket for the build status
[06:00:29.914] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:29.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:90:0) after 1m0s
[06:01:29.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:90:0)
[06:01:29.936] Timer tick, asking Buildbucket for the build status
[06:01:30.072] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:30.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:91:0) after 1m0s
[06:02:30.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:91:0)
[06:02:30.098] Timer tick, asking Buildbucket for the build status
[06:02:30.228] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:30.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:92:0) after 1m0s
[06:03:30.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:92:0)
[06:03:30.262] Timer tick, asking Buildbucket for the build status
[06:03:30.316] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:30.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:93:0) after 1m0s
[06:04:30.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:93:0)
[06:04:30.445] Timer tick, asking Buildbucket for the build status
[06:04:30.538] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:30.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:94:0) after 1m0s
[06:05:30.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:94:0)
[06:05:30.614] Timer tick, asking Buildbucket for the build status
[06:05:30.676] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:30.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:95:0) after 1m0s
[06:06:30.701] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:95:0)
[06:06:30.701] Timer tick, asking Buildbucket for the build status
[06:06:30.856] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:30.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:96:0) after 1m0s
[06:07:30.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:96:0)
[06:07:30.922] Timer tick, asking Buildbucket for the build status
[06:07:30.985] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:30.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:97:0) after 1m0s
[06:08:31.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:97:0)
[06:08:31.021] Timer tick, asking Buildbucket for the build status
[06:08:31.098] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:31.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:98:0) after 1m0s
[06:09:31.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:98:0)
[06:09:31.136] Timer tick, asking Buildbucket for the build status
[06:09:31.385] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:31.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:99:0) after 1m0s
[06:10:31.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:99:0)
[06:10:31.408] Timer tick, asking Buildbucket for the build status
[06:10:31.447] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:31.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:100:0) after 1m0s
[06:11:31.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:100:0)
[06:11:31.473] Timer tick, asking Buildbucket for the build status
[06:11:31.536] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:31.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:101:0) after 1m0s
[06:12:31.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:101:0)
[06:12:31.613] Timer tick, asking Buildbucket for the build status
[06:12:31.669] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:31.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:102:0) after 1m0s
[06:13:31.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:102:0)
[06:13:31.694] Timer tick, asking Buildbucket for the build status
[06:13:31.940] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:31.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:103:0) after 1m0s
[06:14:31.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:103:0)
[06:14:31.968] Timer tick, asking Buildbucket for the build status
[06:14:32.143] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:32.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:104:0) after 1m0s
[06:15:32.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:104:0)
[06:15:32.175] Timer tick, asking Buildbucket for the build status
[06:15:32.252] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:32.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:105:0) after 1m0s
[06:16:32.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:105:0)
[06:16:32.275] Timer tick, asking Buildbucket for the build status
[06:16:32.420] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:32.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:106:0) after 1m0s
[06:17:32.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:106:0)
[06:17:32.442] Timer tick, asking Buildbucket for the build status
[06:17:32.532] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:32.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:107:0) after 1m0s
[06:18:32.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:107:0)
[06:18:32.555] Timer tick, asking Buildbucket for the build status
[06:18:32.655] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:32.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:108:0) after 1m0s
[06:19:32.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:108:0)
[06:19:32.679] Timer tick, asking Buildbucket for the build status
[06:19:32.733] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:32.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:109:0) after 1m0s
[06:20:32.773] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:109:0)
[06:20:32.773] Timer tick, asking Buildbucket for the build status
[06:20:32.880] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:32.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:110:0) after 1m0s
[06:21:32.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:110:0)
[06:21:32.919] Timer tick, asking Buildbucket for the build status
[06:21:33.190] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:33.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:111:0) after 1m0s
[06:22:33.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:111:0)
[06:22:33.245] Timer tick, asking Buildbucket for the build status
[06:22:33.330] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:33.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:112:0) after 1m0s
[06:23:33.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:112:0)
[06:23:33.353] Timer tick, asking Buildbucket for the build status
[06:23:33.395] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:33.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:113:0) after 1m0s
[06:24:33.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:113:0)
[06:24:33.537] Timer tick, asking Buildbucket for the build status
[06:24:33.692] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:33.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:114:0) after 1m0s
[06:25:33.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:114:0)
[06:25:33.718] Timer tick, asking Buildbucket for the build status
[06:25:33.780] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:33.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:115:0) after 1m0s
[06:26:33.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:115:0)
[06:26:33.803] Timer tick, asking Buildbucket for the build status
[06:26:33.863] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:33.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:116:0) after 1m0s
[06:27:33.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:116:0)
[06:27:33.889] Timer tick, asking Buildbucket for the build status
[06:27:33.951] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:33.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:117:0) after 1m0s
[06:28:33.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:117:0)
[06:28:33.973] Timer tick, asking Buildbucket for the build status
[06:28:34.035] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:34.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:118:0) after 1m0s
[06:29:34.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:118:0)
[06:29:34.071] Timer tick, asking Buildbucket for the build status
[06:29:34.142] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:34.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:119:0) after 1m0s
[06:30:34.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:119:0)
[06:30:34.168] Timer tick, asking Buildbucket for the build status
[06:30:34.265] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:34.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:120:0) after 1m0s
[06:31:34.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:120:0)
[06:31:34.292] Timer tick, asking Buildbucket for the build status
[06:31:34.423] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:34.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:121:0) after 1m0s
[06:32:34.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:121:0)
[06:32:34.451] Timer tick, asking Buildbucket for the build status
[06:32:34.560] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:34.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:122:0) after 1m0s
[06:33:34.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:122:0)
[06:33:34.593] Timer tick, asking Buildbucket for the build status
[06:33:34.668] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:34.668] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:123:0) after 1m0s
[06:34:34.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:123:0)
[06:34:34.688] Timer tick, asking Buildbucket for the build status
[06:34:34.818] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:34.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:124:0) after 1m0s
[06:35:34.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:124:0)
[06:35:34.850] Timer tick, asking Buildbucket for the build status
[06:35:34.959] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:34.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:125:0) after 1m0s
[06:36:34.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:125:0)
[06:36:34.987] Timer tick, asking Buildbucket for the build status
[06:36:35.047] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:35.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:126:0) after 1m0s
[06:37:35.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:126:0)
[06:37:35.071] Timer tick, asking Buildbucket for the build status
[06:37:35.123] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:35.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:127:0) after 1m0s
[06:38:35.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:127:0)
[06:38:35.162] Timer tick, asking Buildbucket for the build status
[06:38:35.199] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:35.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:128:0) after 1m0s
[06:39:35.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:128:0)
[06:39:35.223] Timer tick, asking Buildbucket for the build status
[06:39:35.488] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:35.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:129:0) after 1m0s
[06:40:35.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:129:0)
[06:40:35.525] Timer tick, asking Buildbucket for the build status
[06:40:35.563] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:35.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:130:0) after 1m0s
[06:41:35.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:130:0)
[06:41:35.585] Timer tick, asking Buildbucket for the build status
[06:41:35.664] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:35.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:131:0) after 1m0s
[06:42:35.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:131:0)
[06:42:35.696] Timer tick, asking Buildbucket for the build status
[06:42:35.782] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:35.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:132:0) after 1m0s
[06:43:35.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:132:0)
[06:43:35.813] Timer tick, asking Buildbucket for the build status
[06:43:35.938] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:35.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:133:0) after 1m0s
[06:44:35.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:133:0)
[06:44:35.962] Timer tick, asking Buildbucket for the build status
[06:44:36.249] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:36.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:134:0) after 1m0s
[06:45:36.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:134:0)
[06:45:36.279] Timer tick, asking Buildbucket for the build status
[06:45:36.332] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:36.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:135:0) after 1m0s
[06:46:36.360] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:135:0)
[06:46:36.360] Timer tick, asking Buildbucket for the build status
[06:46:36.422] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:36.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:136:0) after 1m0s
[06:47:36.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:136:0)
[06:47:36.490] Timer tick, asking Buildbucket for the build status
[06:47:36.559] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:36.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:137:0) after 1m0s
[06:48:36.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:137:0)
[06:48:36.634] Timer tick, asking Buildbucket for the build status
[06:48:36.673] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:36.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:138:0) after 1m0s
[06:49:36.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:138:0)
[06:49:36.700] Timer tick, asking Buildbucket for the build status
[06:49:36.762] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:36.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:139:0) after 1m0s
[06:50:36.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:139:0)
[06:50:36.792] Timer tick, asking Buildbucket for the build status
[06:50:36.854] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:36.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:140:0) after 1m0s
[06:51:36.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:140:0)
[06:51:36.881] Timer tick, asking Buildbucket for the build status
[06:51:36.918] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:36.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:141:0) after 1m0s
[06:52:36.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:141:0)
[06:52:36.958] Timer tick, asking Buildbucket for the build status
[06:52:37.030] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:37.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:142:0) after 1m0s
[06:53:37.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:142:0)
[06:53:37.056] Timer tick, asking Buildbucket for the build status
[06:53:37.192] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:37.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:143:0) after 1m0s
[06:54:37.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:143:0)
[06:54:37.247] Timer tick, asking Buildbucket for the build status
[06:54:37.319] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:37.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:144:0) after 1m0s
[06:55:37.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:144:0)
[06:55:37.344] Timer tick, asking Buildbucket for the build status
[06:55:37.409] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:37.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:145:0) after 1m0s
[06:56:37.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:145:0)
[06:56:37.439] Timer tick, asking Buildbucket for the build status
[06:56:37.536] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:37.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:146:0) after 1m0s
[06:57:37.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:146:0)
[06:57:37.587] Timer tick, asking Buildbucket for the build status
[06:57:37.665] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:37.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:147:0) after 1m0s
[06:58:37.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:147:0)
[06:58:37.691] Timer tick, asking Buildbucket for the build status
[06:58:37.752] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:37.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:148:0) after 1m0s
[06:59:37.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:148:0)
[06:59:37.782] Timer tick, asking Buildbucket for the build status
[06:59:37.873] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:37.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:149:0) after 1m0s
[07:00:37.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:149:0)
[07:00:37.938] Timer tick, asking Buildbucket for the build status
[07:00:37.999] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:37.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:150:0) after 1m0s
[07:01:38.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:150:0)
[07:01:38.031] Timer tick, asking Buildbucket for the build status
[07:01:38.115] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:38.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:151:0) after 1m0s
[07:02:38.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:151:0)
[07:02:38.184] Timer tick, asking Buildbucket for the build status
[07:02:38.242] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:38.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:152:0) after 1m0s
[07:03:38.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:152:0)
[07:03:38.350] Timer tick, asking Buildbucket for the build status
[07:03:38.460] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:38.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:153:0) after 1m0s
[07:04:38.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:153:0)
[07:04:38.513] Timer tick, asking Buildbucket for the build status
[07:04:38.574] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:38.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:154:0) after 1m0s
[07:05:38.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:154:0)
[07:05:38.714] Timer tick, asking Buildbucket for the build status
[07:05:39.069] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:39.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:155:0) after 1m0s
[07:06:39.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:155:0)
[07:06:39.146] Timer tick, asking Buildbucket for the build status
[07:06:39.213] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:39.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:156:0) after 1m0s
[07:07:39.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:156:0)
[07:07:39.268] Timer tick, asking Buildbucket for the build status
[07:07:39.419] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:39.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:157:0) after 1m0s
[07:08:39.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:157:0)
[07:08:39.442] Timer tick, asking Buildbucket for the build status
[07:08:39.501] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:39.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:158:0) after 1m0s
[07:09:39.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:158:0)
[07:09:39.532] Timer tick, asking Buildbucket for the build status
[07:09:39.596] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:39.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:159:0) after 1m0s
[07:10:39.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:159:0)
[07:10:39.677] Timer tick, asking Buildbucket for the build status
[07:10:39.757] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:39.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:160:0) after 1m0s
[07:11:39.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:160:0)
[07:11:39.784] Timer tick, asking Buildbucket for the build status
[07:11:39.835] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:39.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:161:0) after 1m0s
[07:12:39.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:161:0)
[07:12:39.861] Timer tick, asking Buildbucket for the build status
[07:12:39.926] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:39.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:162:0) after 1m0s
[07:13:40.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:162:0)
[07:13:40.071] Timer tick, asking Buildbucket for the build status
[07:13:40.149] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:40.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:163:0) after 1m0s
[07:14:40.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:163:0)
[07:14:40.175] Timer tick, asking Buildbucket for the build status
[07:14:40.294] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:164:0) after 1m0s
[07:15:40.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:164:0)
[07:15:40.351] Timer tick, asking Buildbucket for the build status
[07:15:40.496] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:40.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:165:0) after 1m0s
[07:16:40.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:165:0)
[07:16:40.556] Timer tick, asking Buildbucket for the build status
[07:16:40.620] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:40.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:166:0) after 1m0s
[07:17:40.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:166:0)
[07:17:40.640] Timer tick, asking Buildbucket for the build status
[07:17:40.724] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:40.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:167:0) after 1m0s
[07:18:40.753] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:167:0)
[07:18:40.753] Timer tick, asking Buildbucket for the build status
[07:18:40.837] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:40.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:168:0) after 1m0s
[07:19:40.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:168:0)
[07:19:40.861] Timer tick, asking Buildbucket for the build status
[07:19:41.153] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:41.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:169:0) after 1m0s
[07:20:41.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:169:0)
[07:20:41.190] Timer tick, asking Buildbucket for the build status
[07:20:41.284] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:41.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:170:0) after 1m0s
[07:21:41.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:170:0)
[07:21:41.316] Timer tick, asking Buildbucket for the build status
[07:21:41.529] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:41.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:171:0) after 1m0s
[07:22:41.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:171:0)
[07:22:41.555] Timer tick, asking Buildbucket for the build status
[07:22:41.886] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:41.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:172:0) after 1m0s
[07:23:41.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:172:0)
[07:23:41.908] Timer tick, asking Buildbucket for the build status
[07:23:41.990] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:41.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:173:0) after 1m0s
[07:24:42.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:173:0)
[07:24:42.014] Timer tick, asking Buildbucket for the build status
[07:24:42.173] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:42.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:174:0) after 1m0s
[07:25:42.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:174:0)
[07:25:42.200] Timer tick, asking Buildbucket for the build status
[07:25:42.296] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:42.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:175:0) after 1m0s
[07:26:42.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:175:0)
[07:26:42.320] Timer tick, asking Buildbucket for the build status
[07:26:42.571] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:42.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:176:0) after 1m0s
[07:27:42.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:176:0)
[07:27:42.667] Timer tick, asking Buildbucket for the build status
[07:27:42.749] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:42.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:177:0) after 1m0s
[07:28:42.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:177:0)
[07:28:42.807] Timer tick, asking Buildbucket for the build status
[07:28:42.916] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:42.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:178:0) after 1m0s
[07:29:42.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:178:0)
[07:29:42.942] Timer tick, asking Buildbucket for the build status
[07:29:43.006] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:43.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:179:0) after 1m0s
[07:30:43.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:179:0)
[07:30:43.057] Timer tick, asking Buildbucket for the build status
[07:30:43.155] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:43.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:180:0) after 1m0s
[07:31:43.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:180:0)
[07:31:43.183] Timer tick, asking Buildbucket for the build status
[07:31:43.258] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:43.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:181:0) after 1m0s
[07:32:43.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:181:0)
[07:32:43.286] Timer tick, asking Buildbucket for the build status
[07:32:43.375] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:43.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:182:0) after 1m0s
[07:33:43.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:182:0)
[07:33:43.401] Timer tick, asking Buildbucket for the build status
[07:33:43.493] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:43.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:183:0) after 1m0s
[07:34:43.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:183:0)
[07:34:43.518] Timer tick, asking Buildbucket for the build status
[07:34:43.607] Build 8931270226968787648: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:43.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9096700289052449296:184:0) after 1m0s
[07:34:44.553] Received PubSub notification, asking Buildbucket for the build status
[07:34:44.607] Build 8931270226968787648: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[07:34:44.607] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "AUTO",
    "completed_ts": "1540884883506887",
    "created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
    "created_ts": "1540873993864903",
    "failure_reason": "INFRA_FAILURE",
    "id": "8931270226968787648",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"72.0.3595.2\"}}",
    "project": "infra",
    "result": "FAILURE",
    "result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3817-6aedaff\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-e833d7b0-us-west1-c-kmrn\"], \"pool\": [\"luci.infra.cron\"], \"caches\": [\"vpython\"]}}, \"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1540874054331067",
    "status": "COMPLETED",
    "status_changed_ts": "1540884884048218",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9096700289052449296",
      "scheduler_job_id:infra/Build From Tarball",
      "swarming_dimension:builder:Build From Tarball",
      "swarming_dimension:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_dimension:cpu:x86-64",
      "swarming_dimension:os:Ubuntu-14.04",
      "swarming_dimension:pool:luci.infra.cron",
      "swarming_hostname:chromium-swarm.appspot.com",
      "swarming_tag:buildbucket_bucket:infra/cron",
      "swarming_tag:buildbucket_build_id:8931270226968787648",
      "swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
      "swarming_tag:buildbucket_template_canary:0",
      "swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
      "swarming_tag:builder:Build From Tarball",
      "swarming_tag:caches:builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2",
      "swarming_tag:cpu:x86-64",
      "swarming_tag:log_location:logdog://logs.chromium.org/infra/buildbucket/cr-buildbucket.appspot.com/8931270226968787648/+/annotations",
      "swarming_tag:luci_project:infra",
      "swarming_tag:os:Ubuntu-14.04",
      "swarming_tag:parent_buildername:publish_tarball",
      "swarming_tag:pool:luci.infra.cron",
      "swarming_tag:priority:30",
      "swarming_tag:recipe_name:build_from_tarball",
      "swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
      "swarming_tag:scheduler_invocation_id:9096700289052449296",
      "swarming_tag:scheduler_job_id:infra/Build From Tarball",
      "swarming_tag:service_account:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
      "swarming_tag:swarming.pool.template:skip",
      "swarming_tag:swarming.pool.version:7e0a382bd146d54a2b93225115f789f999b027c1",
      "swarming_tag:user:None",
      "swarming_tag:user_agent:luci-scheduler",
      "swarming_tag:user_agent:recipe",
      "swarming_tag:vpython:native-python-wrapper",
      "swarming_task_id:40dc10ca7bf85110",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1540884884049079",
    "url": "https://ci.chromium.org/b/8931270226968787648",
    "utcnow_ts": "1540884884596791"
  }
}
[07:34:44.607] Invocation finished in 3h1m32.114367191s with status FAILED