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

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

{
  "version": "87.0.4280.88"
}

• parent_buildername:publish_tarball
• user_agent:recipe

[00:56:13.281] New invocation is queued and will start shortly
[00:56:13.281] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[00:56:14.488] Starting the invocation (attempt 1)
[00:56:14.533] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:56:14.533] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:56:14.533] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9027407261406812880",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"87.0.4280.88\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e096de95-79aa-4ab9-a4c7-6b1f313d7c73\",\"title\":\"publish_tarball/0\"}]},\"version\":\"87.0.4280.88\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9027407261406812880",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[00:56:15.248] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1606956974654689",
    "id": "8861977199303055328",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.88\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e096de95-79aa-4ab9-a4c7-6b1f313d7c73\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.88\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1606956974935839",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9027407261406812880",
      "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/8861977199303055328/+/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": "1606956974936358",
    "url": "https://ci.chromium.org/b/8861977199303055328",
    "utcnow_ts": "1606956975233451"
  }
}
[00:56:15.248] Task URL: https://ci.chromium.org/b/8861977199303055328
[00:56:15.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:2:0) after 1m0s
[00:57:05.127] Received PubSub notification, asking Buildbucket for the build status
[00:57:05.241] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:15.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:2:0)
[00:57:15.271] Timer tick, asking Buildbucket for the build status
[00:57:15.347] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:15.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:4:0) after 1m0s
[00:58:15.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:4:0)
[00:58:15.365] Timer tick, asking Buildbucket for the build status
[00:58:15.481] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:15.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:5:0) after 1m0s
[00:59:15.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:5:0)
[00:59:15.576] Timer tick, asking Buildbucket for the build status
[00:59:15.756] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:15.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:6:0) after 1m0s
[01:00:15.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:6:0)
[01:00:15.848] Timer tick, asking Buildbucket for the build status
[01:00:15.944] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:15.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:7:0) after 1m0s
[01:01:15.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:7:0)
[01:01:15.968] Timer tick, asking Buildbucket for the build status
[01:01:16.258] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:16.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:8:0) after 1m0s
[01:02:16.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:8:0)
[01:02:16.287] Timer tick, asking Buildbucket for the build status
[01:02:16.528] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:16.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:9:0) after 1m0s
[01:03:16.630] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:9:0)
[01:03:16.630] Timer tick, asking Buildbucket for the build status
[01:03:16.844] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:16.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:10:0) after 1m0s
[01:04:16.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:10:0)
[01:04:16.904] Timer tick, asking Buildbucket for the build status
[01:04:17.029] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:17.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:11:0) after 1m0s
[01:05:17.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:11:0)
[01:05:17.061] Timer tick, asking Buildbucket for the build status
[01:05:17.188] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:17.188] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:12:0) after 1m0s
[01:06:17.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:12:0)
[01:06:17.259] Timer tick, asking Buildbucket for the build status
[01:06:17.628] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:17.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:13:0) after 1m0s
[01:07:17.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:13:0)
[01:07:17.700] Timer tick, asking Buildbucket for the build status
[01:07:17.761] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:17.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:14:0) after 1m0s
[01:08:17.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:14:0)
[01:08:17.818] Timer tick, asking Buildbucket for the build status
[01:08:18.061] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:18.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:15:0) after 1m0s
[01:09:18.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:15:0)
[01:09:18.084] Timer tick, asking Buildbucket for the build status
[01:09:18.334] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:18.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:16:0) after 1m0s
[01:10:18.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:16:0)
[01:10:18.351] Timer tick, asking Buildbucket for the build status
[01:10:18.421] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:18.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:17:0) after 1m0s
[01:11:18.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:17:0)
[01:11:18.444] Timer tick, asking Buildbucket for the build status
[01:11:19.000] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:19.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:18:0) after 1m0s
[01:12:19.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:18:0)
[01:12:19.034] Timer tick, asking Buildbucket for the build status
[01:12:19.111] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:19.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:19:0) after 1m0s
[01:13:19.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:19:0)
[01:13:19.126] Timer tick, asking Buildbucket for the build status
[01:13:19.202] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:19.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:20:0) after 1m0s
[01:14:19.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:20:0)
[01:14:19.210] Timer tick, asking Buildbucket for the build status
[01:14:19.330] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:19.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:21:0) after 1m0s
[01:15:19.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:21:0)
[01:15:19.332] Timer tick, asking Buildbucket for the build status
[01:15:19.391] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:19.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:22:0) after 1m0s
[01:16:19.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:22:0)
[01:16:19.495] Timer tick, asking Buildbucket for the build status
[01:16:19.605] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:19.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:23:0) after 1m0s
[01:17:19.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:23:0)
[01:17:19.611] Timer tick, asking Buildbucket for the build status
[01:17:19.681] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:19.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:24:0) after 1m0s
[01:18:19.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:24:0)
[01:18:19.870] Timer tick, asking Buildbucket for the build status
[01:18:19.980] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:25:0) after 1m0s
[01:19:19.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:25:0)
[01:19:19.964] Timer tick, asking Buildbucket for the build status
[01:19:20.023] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:20.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:26:0) after 1m0s
[01:20:20.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:26:0)
[01:20:20.090] Timer tick, asking Buildbucket for the build status
[01:20:20.279] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:20.279] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:27:0) after 1m0s
[01:21:20.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:27:0)
[01:21:20.332] Timer tick, asking Buildbucket for the build status
[01:21:20.452] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:20.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:28:0) after 1m0s
[01:22:20.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:28:0)
[01:22:20.482] Timer tick, asking Buildbucket for the build status
[01:22:20.565] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:20.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:29:0) after 1m0s
[01:23:20.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:29:0)
[01:23:20.615] Timer tick, asking Buildbucket for the build status
[01:23:20.763] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:20.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:30:0) after 1m0s
[01:24:20.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:30:0)
[01:24:20.889] Timer tick, asking Buildbucket for the build status
[01:24:20.980] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:20.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:31:0) after 1m0s
[01:25:21.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:31:0)
[01:25:21.045] Timer tick, asking Buildbucket for the build status
[01:25:21.121] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:21.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:32:0) after 1m0s
[01:26:21.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:32:0)
[01:26:21.371] Timer tick, asking Buildbucket for the build status
[01:26:21.586] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:21.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:33:0) after 1m0s
[01:27:21.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:33:0)
[01:27:21.613] Timer tick, asking Buildbucket for the build status
[01:27:21.833] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:21.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:34:0) after 1m0s
[01:28:22.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:34:0)
[01:28:22.019] Timer tick, asking Buildbucket for the build status
[01:28:22.361] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:22.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:35:0) after 1m0s
[01:29:22.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:35:0)
[01:29:22.421] Timer tick, asking Buildbucket for the build status
[01:29:22.480] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:22.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:36:0) after 1m0s
[01:30:22.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:36:0)
[01:30:22.615] Timer tick, asking Buildbucket for the build status
[01:30:22.983] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:22.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:37:0) after 1m0s
[01:31:23.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:37:0)
[01:31:23.027] Timer tick, asking Buildbucket for the build status
[01:31:23.137] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:23.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:38:0) after 1m0s
[01:32:23.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:38:0)
[01:32:23.213] Timer tick, asking Buildbucket for the build status
[01:32:23.275] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:23.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:39:0) after 1m0s
[01:33:23.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:39:0)
[01:33:23.301] Timer tick, asking Buildbucket for the build status
[01:33:23.355] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:23.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:40:0) after 1m0s
[01:34:23.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:40:0)
[01:34:23.389] Timer tick, asking Buildbucket for the build status
[01:34:23.564] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:23.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:41:0) after 1m0s
[01:35:23.631] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:41:0)
[01:35:23.631] Timer tick, asking Buildbucket for the build status
[01:35:23.707] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:23.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:42:0) after 1m0s
[01:36:23.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:42:0)
[01:36:23.778] Timer tick, asking Buildbucket for the build status
[01:36:24.151] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:24.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:43:0) after 1m0s
[01:37:24.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:43:0)
[01:37:24.173] Timer tick, asking Buildbucket for the build status
[01:37:24.234] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:24.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:44:0) after 1m0s
[01:38:24.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:44:0)
[01:38:24.285] Timer tick, asking Buildbucket for the build status
[01:38:24.479] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:24.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:45:0) after 1m0s
[01:39:24.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:45:0)
[01:39:24.494] Timer tick, asking Buildbucket for the build status
[01:39:24.573] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:24.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:46:0) after 1m0s
[01:40:24.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:46:0)
[01:40:24.629] Timer tick, asking Buildbucket for the build status
[01:40:24.709] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:24.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:47:0) after 1m0s
[01:41:24.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:47:0)
[01:41:24.838] Timer tick, asking Buildbucket for the build status
[01:41:25.141] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:25.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:48:0) after 1m0s
[01:42:25.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:48:0)
[01:42:25.185] Timer tick, asking Buildbucket for the build status
[01:42:25.315] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:25.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:49:0) after 1m0s
[01:43:25.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:49:0)
[01:43:25.318] Timer tick, asking Buildbucket for the build status
[01:43:25.377] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:25.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:50:0) after 1m0s
[01:44:25.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:50:0)
[01:44:25.428] Timer tick, asking Buildbucket for the build status
[01:44:25.501] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:25.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:51:0) after 1m0s
[01:45:25.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:51:0)
[01:45:25.484] Timer tick, asking Buildbucket for the build status
[01:45:25.783] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:25.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:52:0) after 1m0s
[01:46:25.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:52:0)
[01:46:25.825] Timer tick, asking Buildbucket for the build status
[01:46:26.005] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:26.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:53:0) after 1m0s
[01:47:25.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:53:0)
[01:47:25.999] Timer tick, asking Buildbucket for the build status
[01:47:26.088] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:26.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:54:0) after 1m0s
[01:48:26.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:54:0)
[01:48:26.143] Timer tick, asking Buildbucket for the build status
[01:48:26.270] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:26.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:55:0) after 1m0s
[01:49:26.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:55:0)
[01:49:26.288] Timer tick, asking Buildbucket for the build status
[01:49:26.437] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:26.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:56:0) after 1m0s
[01:50:26.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:56:0)
[01:50:26.764] Timer tick, asking Buildbucket for the build status
[01:50:26.924] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:26.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:57:0) after 1m0s
[01:51:26.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:57:0)
[01:51:26.973] Timer tick, asking Buildbucket for the build status
[01:51:27.078] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:27.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:58:0) after 1m0s
[01:52:27.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:58:0)
[01:52:27.182] Timer tick, asking Buildbucket for the build status
[01:52:27.258] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:27.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:59:0) after 1m0s
[01:53:27.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:59:0)
[01:53:27.317] Timer tick, asking Buildbucket for the build status
[01:53:27.942] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:27.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:60:0) after 1m0s
[01:54:28.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:60:0)
[01:54:28.058] Timer tick, asking Buildbucket for the build status
[01:54:28.113] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:28.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:61:0) after 1m0s
[01:55:28.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:61:0)
[01:55:28.251] Timer tick, asking Buildbucket for the build status
[01:55:28.317] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:28.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:62:0) after 1m0s
[01:56:28.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:62:0)
[01:56:28.375] Timer tick, asking Buildbucket for the build status
[01:56:28.852] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:28.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:63:0) after 1m0s
[01:57:28.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:63:0)
[01:57:28.897] Timer tick, asking Buildbucket for the build status
[01:57:29.277] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:29.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:64:0) after 1m0s
[01:58:29.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:64:0)
[01:58:29.324] Timer tick, asking Buildbucket for the build status
[01:58:29.414] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:29.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:65:0) after 1m0s
[01:59:29.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:65:0)
[01:59:29.487] Timer tick, asking Buildbucket for the build status
[01:59:29.550] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:29.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:66:0) after 1m0s
[02:00:29.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:66:0)
[02:00:29.590] Timer tick, asking Buildbucket for the build status
[02:00:29.690] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:29.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:67:0) after 1m0s
[02:01:29.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:67:0)
[02:01:29.777] Timer tick, asking Buildbucket for the build status
[02:01:30.614] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:30.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:68:0) after 1m0s
[02:02:30.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:68:0)
[02:02:30.636] Timer tick, asking Buildbucket for the build status
[02:02:30.735] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:69:0) after 1m0s
[02:03:30.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:69:0)
[02:03:30.765] Timer tick, asking Buildbucket for the build status
[02:03:30.821] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:30.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:70:0) after 1m0s
[02:04:30.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:70:0)
[02:04:30.974] Timer tick, asking Buildbucket for the build status
[02:04:31.052] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:71:0) after 1m0s
[02:05:31.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:71:0)
[02:05:31.167] Timer tick, asking Buildbucket for the build status
[02:05:31.408] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:72:0) after 1m0s
[02:06:31.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:72:0)
[02:06:31.484] Timer tick, asking Buildbucket for the build status
[02:06:31.799] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:31.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:73:0) after 1m0s
[02:07:31.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:73:0)
[02:07:31.859] Timer tick, asking Buildbucket for the build status
[02:07:32.083] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:32.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:74:0) after 1m0s
[02:08:32.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:74:0)
[02:08:32.358] Timer tick, asking Buildbucket for the build status
[02:08:32.421] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:32.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:75:0) after 1m0s
[02:09:32.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:75:0)
[02:09:32.734] Timer tick, asking Buildbucket for the build status
[02:09:33.085] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:33.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:76:0) after 1m0s
[02:10:33.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:76:0)
[02:10:33.214] Timer tick, asking Buildbucket for the build status
[02:10:33.272] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:33.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:77:0) after 1m0s
[02:11:33.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:77:0)
[02:11:33.370] Timer tick, asking Buildbucket for the build status
[02:11:33.998] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:33.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:78:0) after 1m0s
[02:12:34.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:78:0)
[02:12:34.059] Timer tick, asking Buildbucket for the build status
[02:12:34.185] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:34.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:79:0) after 1m0s
[02:13:34.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:79:0)
[02:13:34.165] Timer tick, asking Buildbucket for the build status
[02:13:34.270] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:34.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:80:0) after 1m0s
[02:14:34.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:80:0)
[02:14:34.321] Timer tick, asking Buildbucket for the build status
[02:14:34.484] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:34.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:81:0) after 1m0s
[02:15:34.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:81:0)
[02:15:34.572] Timer tick, asking Buildbucket for the build status
[02:15:34.842] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:34.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:82:0) after 1m0s
[02:16:34.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:82:0)
[02:16:34.861] Timer tick, asking Buildbucket for the build status
[02:16:34.971] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:83:0) after 1m0s
[02:17:34.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:83:0)
[02:17:34.978] Timer tick, asking Buildbucket for the build status
[02:17:35.036] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:35.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:84:0) after 1m0s
[02:18:35.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:84:0)
[02:18:35.038] Timer tick, asking Buildbucket for the build status
[02:18:35.143] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:35.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:85:0) after 1m0s
[02:19:35.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:85:0)
[02:19:35.165] Timer tick, asking Buildbucket for the build status
[02:19:35.593] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:35.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:86:0) after 1m0s
[02:20:35.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:86:0)
[02:20:35.618] Timer tick, asking Buildbucket for the build status
[02:20:35.737] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:35.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:87:0) after 1m0s
[02:21:35.747] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:87:0)
[02:21:35.747] Timer tick, asking Buildbucket for the build status
[02:21:36.153] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:36.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:88:0) after 1m0s
[02:22:36.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:88:0)
[02:22:36.158] Timer tick, asking Buildbucket for the build status
[02:22:36.217] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:36.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:89:0) after 1m0s
[02:23:36.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:89:0)
[02:23:36.248] Timer tick, asking Buildbucket for the build status
[02:23:36.407] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:36.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:90:0) after 1m0s
[02:24:36.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:90:0)
[02:24:36.468] Timer tick, asking Buildbucket for the build status
[02:24:36.571] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:36.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:91:0) after 1m0s
[02:25:36.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:91:0)
[02:25:36.644] Timer tick, asking Buildbucket for the build status
[02:25:36.787] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:36.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:92:0) after 1m0s
[02:26:36.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:92:0)
[02:26:36.883] Timer tick, asking Buildbucket for the build status
[02:26:37.120] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:37.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:93:0) after 1m0s
[02:27:37.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:93:0)
[02:27:37.206] Timer tick, asking Buildbucket for the build status
[02:27:37.432] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:37.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:94:0) after 1m0s
[02:28:37.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:94:0)
[02:28:37.588] Timer tick, asking Buildbucket for the build status
[02:28:37.709] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:37.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:95:0) after 1m0s
[02:29:37.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:95:0)
[02:29:37.951] Timer tick, asking Buildbucket for the build status
[02:29:38.023] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:38.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:96:0) after 1m0s
[02:30:38.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:96:0)
[02:30:38.006] Timer tick, asking Buildbucket for the build status
[02:30:38.117] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:97:0) after 1m0s
[02:31:38.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:97:0)
[02:31:38.372] Timer tick, asking Buildbucket for the build status
[02:31:38.458] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:98:0) after 1m0s
[02:32:38.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:98:0)
[02:32:38.624] Timer tick, asking Buildbucket for the build status
[02:32:38.702] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:38.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:99:0) after 1m0s
[02:33:38.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:99:0)
[02:33:38.807] Timer tick, asking Buildbucket for the build status
[02:33:38.884] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:38.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:100:0) after 1m0s
[02:34:39.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:100:0)
[02:34:39.086] Timer tick, asking Buildbucket for the build status
[02:34:39.313] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:39.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:101:0) after 1m0s
[02:35:39.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:101:0)
[02:35:39.475] Timer tick, asking Buildbucket for the build status
[02:35:39.734] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:39.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:102:0) after 1m0s
[02:36:39.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:102:0)
[02:36:39.936] Timer tick, asking Buildbucket for the build status
[02:36:40.066] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:103:0) after 1m0s
[02:37:40.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:103:0)
[02:37:40.308] Timer tick, asking Buildbucket for the build status
[02:37:40.403] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:104:0) after 1m0s
[02:38:40.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:104:0)
[02:38:40.428] Timer tick, asking Buildbucket for the build status
[02:38:40.490] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:105:0) after 1m0s
[02:39:40.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:105:0)
[02:39:40.640] Timer tick, asking Buildbucket for the build status
[02:39:40.695] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:40.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:106:0) after 1m0s
[02:40:40.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:106:0)
[02:40:40.850] Timer tick, asking Buildbucket for the build status
[02:40:40.916] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:40.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:107:0) after 1m0s
[02:41:41.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:107:0)
[02:41:41.020] Timer tick, asking Buildbucket for the build status
[02:41:41.143] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:108:0) after 1m0s
[02:42:41.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:108:0)
[02:42:41.255] Timer tick, asking Buildbucket for the build status
[02:42:41.492] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:41.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:109:0) after 1m0s
[02:43:41.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:109:0)
[02:43:41.515] Timer tick, asking Buildbucket for the build status
[02:43:41.986] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:41.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:110:0) after 1m0s
[02:44:41.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:110:0)
[02:44:41.978] Timer tick, asking Buildbucket for the build status
[02:44:42.322] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:111:0) after 1m0s
[02:45:42.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:111:0)
[02:45:42.373] Timer tick, asking Buildbucket for the build status
[02:45:42.437] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:42.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:112:0) after 1m0s
[02:46:42.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:112:0)
[02:46:42.544] Timer tick, asking Buildbucket for the build status
[02:46:42.826] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:42.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:113:0) after 1m0s
[02:47:42.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:113:0)
[02:47:42.871] Timer tick, asking Buildbucket for the build status
[02:47:42.942] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:42.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:114:0) after 1m0s
[02:48:42.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:114:0)
[02:48:42.999] Timer tick, asking Buildbucket for the build status
[02:48:43.148] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:115:0) after 1m0s
[02:49:43.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:115:0)
[02:49:43.183] Timer tick, asking Buildbucket for the build status
[02:49:43.376] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:43.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:116:0) after 1m0s
[02:50:43.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:116:0)
[02:50:43.430] Timer tick, asking Buildbucket for the build status
[02:50:43.496] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:43.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:117:0) after 1m0s
[02:51:43.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:117:0)
[02:51:43.566] Timer tick, asking Buildbucket for the build status
[02:51:43.730] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:43.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:118:0) after 1m0s
[02:52:43.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:118:0)
[02:52:43.827] Timer tick, asking Buildbucket for the build status
[02:52:43.899] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:43.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:119:0) after 1m0s
[02:53:44.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:119:0)
[02:53:44.039] Timer tick, asking Buildbucket for the build status
[02:53:44.465] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:44.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:120:0) after 1m0s
[02:54:44.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:120:0)
[02:54:44.516] Timer tick, asking Buildbucket for the build status
[02:54:44.586] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:44.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:121:0) after 1m0s
[02:55:44.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:121:0)
[02:55:44.714] Timer tick, asking Buildbucket for the build status
[02:55:44.810] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:44.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:122:0) after 1m0s
[02:56:44.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:122:0)
[02:56:44.874] Timer tick, asking Buildbucket for the build status
[02:56:44.999] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:44.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:123:0) after 1m0s
[02:57:45.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:123:0)
[02:57:45.072] Timer tick, asking Buildbucket for the build status
[02:57:45.146] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:124:0) after 1m0s
[02:58:45.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:124:0)
[02:58:45.193] Timer tick, asking Buildbucket for the build status
[02:58:45.350] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:45.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:125:0) after 1m0s
[02:59:45.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:125:0)
[02:59:45.373] Timer tick, asking Buildbucket for the build status
[02:59:45.604] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:45.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:126:0) after 1m0s
[03:00:45.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:126:0)
[03:00:45.644] Timer tick, asking Buildbucket for the build status
[03:00:45.722] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:45.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:127:0) after 1m0s
[03:01:45.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:127:0)
[03:01:45.756] Timer tick, asking Buildbucket for the build status
[03:01:45.857] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:45.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:128:0) after 1m0s
[03:02:45.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:128:0)
[03:02:45.879] Timer tick, asking Buildbucket for the build status
[03:02:45.946] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:45.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:129:0) after 1m0s
[03:03:45.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:129:0)
[03:03:45.954] Timer tick, asking Buildbucket for the build status
[03:03:46.014] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:46.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:130:0) after 1m0s
[03:04:46.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:130:0)
[03:04:46.047] Timer tick, asking Buildbucket for the build status
[03:04:46.135] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:46.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:131:0) after 1m0s
[03:05:46.157] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:131:0)
[03:05:46.157] Timer tick, asking Buildbucket for the build status
[03:05:46.215] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:46.215] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:132:0) after 1m0s
[03:06:46.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:132:0)
[03:06:46.248] Timer tick, asking Buildbucket for the build status
[03:06:46.445] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:46.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:133:0) after 1m0s
[03:07:46.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:133:0)
[03:07:46.471] Timer tick, asking Buildbucket for the build status
[03:07:46.525] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:46.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:134:0) after 1m0s
[03:08:46.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:134:0)
[03:08:46.548] Timer tick, asking Buildbucket for the build status
[03:08:46.617] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:46.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:135:0) after 1m0s
[03:09:46.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:135:0)
[03:09:46.665] Timer tick, asking Buildbucket for the build status
[03:09:46.757] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:46.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:136:0) after 1m0s
[03:10:46.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:136:0)
[03:10:46.861] Timer tick, asking Buildbucket for the build status
[03:10:46.984] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:137:0) after 1m0s
[03:11:47.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:137:0)
[03:11:47.042] Timer tick, asking Buildbucket for the build status
[03:11:47.146] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:47.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:138:0) after 1m0s
[03:12:47.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:138:0)
[03:12:47.172] Timer tick, asking Buildbucket for the build status
[03:12:47.257] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:47.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:139:0) after 1m0s
[03:13:47.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:139:0)
[03:13:47.338] Timer tick, asking Buildbucket for the build status
[03:13:47.410] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:47.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:140:0) after 1m0s
[03:14:47.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:140:0)
[03:14:47.436] Timer tick, asking Buildbucket for the build status
[03:14:47.677] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:47.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:141:0) after 1m0s
[03:15:47.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:141:0)
[03:15:47.887] Timer tick, asking Buildbucket for the build status
[03:15:47.958] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:47.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:142:0) after 1m0s
[03:16:47.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:142:0)
[03:16:47.984] Timer tick, asking Buildbucket for the build status
[03:16:48.134] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:48.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:143:0) after 1m0s
[03:17:48.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:143:0)
[03:17:48.144] Timer tick, asking Buildbucket for the build status
[03:17:48.209] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:48.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:144:0) after 1m0s
[03:18:48.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:144:0)
[03:18:48.283] Timer tick, asking Buildbucket for the build status
[03:18:48.425] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:48.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:145:0) after 1m0s
[03:19:48.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:145:0)
[03:19:48.447] Timer tick, asking Buildbucket for the build status
[03:19:48.585] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:48.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:146:0) after 1m0s
[03:20:48.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:146:0)
[03:20:48.644] Timer tick, asking Buildbucket for the build status
[03:20:49.837] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:49.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:147:0) after 1m0s
[03:21:49.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:147:0)
[03:21:49.870] Timer tick, asking Buildbucket for the build status
[03:21:50.066] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:50.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:148:0) after 1m0s
[03:22:50.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:148:0)
[03:22:50.045] Timer tick, asking Buildbucket for the build status
[03:22:50.179] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:50.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:149:0) after 1m0s
[03:23:50.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:149:0)
[03:23:50.238] Timer tick, asking Buildbucket for the build status
[03:23:50.328] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:50.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:150:0) after 1m0s
[03:24:50.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:150:0)
[03:24:50.352] Timer tick, asking Buildbucket for the build status
[03:24:50.416] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:50.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:151:0) after 1m0s
[03:25:50.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:151:0)
[03:25:50.449] Timer tick, asking Buildbucket for the build status
[03:25:50.506] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:50.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:152:0) after 1m0s
[03:26:50.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:152:0)
[03:26:50.560] Timer tick, asking Buildbucket for the build status
[03:26:50.662] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:50.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:153:0) after 1m0s
[03:27:50.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:153:0)
[03:27:50.683] Timer tick, asking Buildbucket for the build status
[03:27:50.769] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:50.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:154:0) after 1m0s
[03:28:50.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:154:0)
[03:28:50.818] Timer tick, asking Buildbucket for the build status
[03:28:52.860] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:52.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:155:0) after 1m0s
[03:29:52.884] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:155:0)
[03:29:52.884] Timer tick, asking Buildbucket for the build status
[03:29:53.282] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:156:0) after 1m0s
[03:30:53.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:156:0)
[03:30:53.363] Timer tick, asking Buildbucket for the build status
[03:30:53.445] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:53.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:157:0) after 1m0s
[03:31:53.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:157:0)
[03:31:53.486] Timer tick, asking Buildbucket for the build status
[03:31:53.831] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:158:0) after 1m0s
[03:32:53.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:158:0)
[03:32:53.898] Timer tick, asking Buildbucket for the build status
[03:32:54.007] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:54.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:159:0) after 1m0s
[03:33:54.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:159:0)
[03:33:54.031] Timer tick, asking Buildbucket for the build status
[03:33:54.109] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:54.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:160:0) after 1m0s
[03:34:54.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:160:0)
[03:34:54.129] Timer tick, asking Buildbucket for the build status
[03:34:54.381] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:161:0) after 1m0s
[03:35:54.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:161:0)
[03:35:54.395] Timer tick, asking Buildbucket for the build status
[03:35:55.307] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:55.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:162:0) after 1m0s
[03:36:55.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:162:0)
[03:36:55.322] Timer tick, asking Buildbucket for the build status
[03:36:55.464] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:55.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:163:0) after 1m0s
[03:37:55.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:163:0)
[03:37:55.494] Timer tick, asking Buildbucket for the build status
[03:37:55.876] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:55.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:164:0) after 1m0s
[03:38:55.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:164:0)
[03:38:55.953] Timer tick, asking Buildbucket for the build status
[03:38:56.216] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:56.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:165:0) after 1m0s
[03:39:56.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:165:0)
[03:39:56.243] Timer tick, asking Buildbucket for the build status
[03:39:56.312] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:56.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:166:0) after 1m0s
[03:40:56.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:166:0)
[03:40:56.330] Timer tick, asking Buildbucket for the build status
[03:40:56.400] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:56.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:167:0) after 1m0s
[03:41:57.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:167:0)
[03:41:57.108] Timer tick, asking Buildbucket for the build status
[03:41:57.449] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:57.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:168:0) after 1m0s
[03:42:57.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:168:0)
[03:42:57.656] Timer tick, asking Buildbucket for the build status
[03:42:57.751] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:57.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:169:0) after 1m0s
[03:43:58.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:169:0)
[03:43:58.003] Timer tick, asking Buildbucket for the build status
[03:43:58.074] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:58.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:170:0) after 1m0s
[03:44:58.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:170:0)
[03:44:58.161] Timer tick, asking Buildbucket for the build status
[03:44:58.435] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:58.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:171:0) after 1m0s
[03:45:58.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:171:0)
[03:45:58.609] Timer tick, asking Buildbucket for the build status
[03:45:58.665] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:58.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:172:0) after 1m0s
[03:46:58.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:172:0)
[03:46:58.784] Timer tick, asking Buildbucket for the build status
[03:46:59.448] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:59.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:173:0) after 1m0s
[03:47:59.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:173:0)
[03:47:59.556] Timer tick, asking Buildbucket for the build status
[03:47:59.626] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:59.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:174:0) after 1m0s
[03:48:59.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:174:0)
[03:48:59.613] Timer tick, asking Buildbucket for the build status
[03:48:59.687] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:59.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:175:0) after 1m0s
[03:49:59.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:175:0)
[03:49:59.695] Timer tick, asking Buildbucket for the build status
[03:49:59.820] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:59.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:176:0) after 1m0s
[03:50:59.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:176:0)
[03:50:59.796] Timer tick, asking Buildbucket for the build status
[03:50:59.865] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:59.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:177:0) after 1m0s
[03:51:59.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:177:0)
[03:51:59.908] Timer tick, asking Buildbucket for the build status
[03:52:00.508] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:00.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:178:0) after 1m0s
[03:53:00.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:178:0)
[03:53:00.848] Timer tick, asking Buildbucket for the build status
[03:53:00.938] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:00.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:179:0) after 1m0s
[03:54:00.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:179:0)
[03:54:00.918] Timer tick, asking Buildbucket for the build status
[03:54:01.173] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:01.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:180:0) after 1m0s
[03:55:02.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:180:0)
[03:55:02.115] Timer tick, asking Buildbucket for the build status
[03:55:02.185] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:02.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:181:0) after 1m0s
[03:56:02.505] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:181:0)
[03:56:02.505] Timer tick, asking Buildbucket for the build status
[03:56:02.567] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:02.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:182:0) after 1m0s
[03:57:02.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:182:0)
[03:57:02.685] Timer tick, asking Buildbucket for the build status
[03:57:03.510] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:03.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:183:0) after 1m0s
[03:58:03.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:183:0)
[03:58:03.600] Timer tick, asking Buildbucket for the build status
[03:58:03.728] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:03.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:184:0) after 1m0s
[03:59:03.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:184:0)
[03:59:03.751] Timer tick, asking Buildbucket for the build status
[03:59:03.846] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:03.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:185:0) after 1m0s
[04:00:03.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:185:0)
[04:00:03.949] Timer tick, asking Buildbucket for the build status
[04:00:04.027] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:04.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:186:0) after 1m0s
[04:01:04.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:186:0)
[04:01:04.609] Timer tick, asking Buildbucket for the build status
[04:01:04.687] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:04.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:187:0) after 1m0s
[04:02:04.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:187:0)
[04:02:04.903] Timer tick, asking Buildbucket for the build status
[04:02:04.998] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:04.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:188:0) after 1m0s
[04:03:05.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:188:0)
[04:03:05.507] Timer tick, asking Buildbucket for the build status
[04:03:05.581] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:05.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:189:0) after 1m0s
[04:04:05.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:189:0)
[04:04:05.782] Timer tick, asking Buildbucket for the build status
[04:04:05.854] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:05.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:190:0) after 1m0s
[04:05:05.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:190:0)
[04:05:05.924] Timer tick, asking Buildbucket for the build status
[04:05:06.007] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:06.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:191:0) after 1m0s
[04:06:06.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:191:0)
[04:06:06.240] Timer tick, asking Buildbucket for the build status
[04:06:06.750] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:06.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:192:0) after 1m0s
[04:07:06.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:192:0)
[04:07:06.871] Timer tick, asking Buildbucket for the build status
[04:07:07.059] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:07.060] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:193:0) after 1m0s
[04:08:07.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:193:0)
[04:08:07.048] Timer tick, asking Buildbucket for the build status
[04:08:07.199] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:07.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:194:0) after 1m0s
[04:09:07.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:194:0)
[04:09:07.318] Timer tick, asking Buildbucket for the build status
[04:09:07.464] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:07.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:195:0) after 1m0s
[04:10:07.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:195:0)
[04:10:07.510] Timer tick, asking Buildbucket for the build status
[04:10:07.606] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:07.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:196:0) after 1m0s
[04:11:07.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:196:0)
[04:11:07.865] Timer tick, asking Buildbucket for the build status
[04:11:08.099] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:08.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:197:0) after 1m0s
[04:12:08.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:197:0)
[04:12:08.114] Timer tick, asking Buildbucket for the build status
[04:12:08.369] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:08.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:198:0) after 1m0s
[04:13:08.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:198:0)
[04:13:08.480] Timer tick, asking Buildbucket for the build status
[04:13:10.191] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:10.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:199:0) after 1m0s
[04:14:10.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:199:0)
[04:14:10.227] Timer tick, asking Buildbucket for the build status
[04:14:10.291] Build 8861977199303055328: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:10.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027407261406812880:200:0) after 1m0s
[04:15:00.334] Received PubSub notification, asking Buildbucket for the build status
[04:15:00.400] Build 8861977199303055328: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:15:00.400] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1606968899191397",
    "created_by": "project:infra",
    "created_ts": "1606956974654689",
    "id": "8861977199303055328",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"87.0.4280.88\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e096de95-79aa-4ab9-a4c7-6b1f313d7c73\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"87.0.4280.88\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-u548\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1606957024199494",
    "status": "COMPLETED",
    "status_changed_ts": "1606968899651781",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9027407261406812880",
      "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/8861977199303055328/+/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:503eeb0dad346b10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1606968899767078",
    "url": "https://ci.chromium.org/b/8861977199303055328",
    "utcnow_ts": "1606968900391781"
  }
}
[04:15:00.400] Invocation finished in 3h18m47.135083687s with status SUCCEEDED