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

• parent_buildername:publish_tarball
• user_agent:recipe

[00:35:47.355] New invocation is queued and will start shortly
[00:35:47.355] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[00:35:48.431] Starting the invocation (attempt 1)
[00:35:48.489] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:35:48.489] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:35:48.489] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9043263016002527152",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4168.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"e41ed997-5bc4-4a04-867f-694ae1088dda\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4168.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9043263016002527152",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[00:35:49.290] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1591835748635906",
    "id": "8877832953997360944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4168.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e41ed997-5bc4-4a04-867f-694ae1088dda\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4168.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1591835748981456",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043263016002527152",
      "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/8877832953997360944/+/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": "1591835748981578",
    "url": "https://ci.chromium.org/b/8877832953997360944",
    "utcnow_ts": "1591835749274669"
  }
}
[00:35:49.290] Task URL: https://ci.chromium.org/b/8877832953997360944
[00:35:49.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:2:0) after 1m0s
[00:36:22.787] Received PubSub notification, asking Buildbucket for the build status
[00:36:22.909] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:49.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:2:0)
[00:36:49.434] Timer tick, asking Buildbucket for the build status
[00:36:49.551] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:49.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:4:0) after 1m0s
[00:37:49.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:4:0)
[00:37:49.554] Timer tick, asking Buildbucket for the build status
[00:37:49.902] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:49.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:5:0) after 1m0s
[00:38:49.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:5:0)
[00:38:49.945] Timer tick, asking Buildbucket for the build status
[00:38:50.277] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:50.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:6:0) after 1m0s
[00:39:50.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:6:0)
[00:39:50.364] Timer tick, asking Buildbucket for the build status
[00:39:50.483] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:50.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:7:0) after 1m0s
[00:40:50.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:7:0)
[00:40:50.574] Timer tick, asking Buildbucket for the build status
[00:40:50.875] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:50.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:8:0) after 1m0s
[00:41:50.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:8:0)
[00:41:50.951] Timer tick, asking Buildbucket for the build status
[00:41:51.419] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:51.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:9:0) after 1m0s
[00:42:51.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:9:0)
[00:42:51.441] Timer tick, asking Buildbucket for the build status
[00:42:51.597] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:51.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:10:0) after 1m0s
[00:43:51.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:10:0)
[00:43:51.602] Timer tick, asking Buildbucket for the build status
[00:43:52.144] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:52.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:11:0) after 1m0s
[00:44:52.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:11:0)
[00:44:52.205] Timer tick, asking Buildbucket for the build status
[00:44:52.398] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:52.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:12:0) after 1m0s
[00:45:52.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:12:0)
[00:45:52.475] Timer tick, asking Buildbucket for the build status
[00:45:52.630] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:52.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:13:0) after 1m0s
[00:46:52.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:13:0)
[00:46:52.703] Timer tick, asking Buildbucket for the build status
[00:46:53.155] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:53.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:14:0) after 1m0s
[00:47:53.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:14:0)
[00:47:53.225] Timer tick, asking Buildbucket for the build status
[00:47:53.538] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:53.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:15:0) after 1m0s
[00:48:53.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:15:0)
[00:48:53.703] Timer tick, asking Buildbucket for the build status
[00:48:53.868] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:53.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:16:0) after 1m0s
[00:49:54.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:16:0)
[00:49:54.036] Timer tick, asking Buildbucket for the build status
[00:49:54.413] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:54.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:17:0) after 1m0s
[00:50:54.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:17:0)
[00:50:54.465] Timer tick, asking Buildbucket for the build status
[00:50:54.614] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:54.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:18:0) after 1m0s
[00:51:54.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:18:0)
[00:51:54.654] Timer tick, asking Buildbucket for the build status
[00:51:55.489] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:55.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:19:0) after 1m0s
[00:52:55.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:19:0)
[00:52:55.559] Timer tick, asking Buildbucket for the build status
[00:52:55.854] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:55.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:20:0) after 1m0s
[00:53:55.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:20:0)
[00:53:55.834] Timer tick, asking Buildbucket for the build status
[00:53:55.980] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:55.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:21:0) after 1m0s
[00:54:56.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:21:0)
[00:54:56.072] Timer tick, asking Buildbucket for the build status
[00:54:56.358] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:56.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:22:0) after 1m0s
[00:55:56.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:22:0)
[00:55:56.430] Timer tick, asking Buildbucket for the build status
[00:55:56.609] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:56.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:23:0) after 1m0s
[00:56:56.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:23:0)
[00:56:56.859] Timer tick, asking Buildbucket for the build status
[00:56:57.618] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:57.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:24:0) after 1m0s
[00:57:57.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:24:0)
[00:57:57.927] Timer tick, asking Buildbucket for the build status
[00:57:58.091] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:58.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:25:0) after 1m0s
[00:58:58.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:25:0)
[00:58:58.134] Timer tick, asking Buildbucket for the build status
[00:58:58.374] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:58.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:26:0) after 1m0s
[00:59:58.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:26:0)
[00:59:58.458] Timer tick, asking Buildbucket for the build status
[00:59:58.845] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:58.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:27:0) after 1m0s
[01:00:58.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:27:0)
[01:00:58.903] Timer tick, asking Buildbucket for the build status
[01:00:59.047] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:59.047] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:28:0) after 1m0s
[01:01:59.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:28:0)
[01:01:59.051] Timer tick, asking Buildbucket for the build status
[01:01:59.641] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:59.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:29:0) after 1m0s
[01:02:59.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:29:0)
[01:02:59.657] Timer tick, asking Buildbucket for the build status
[01:02:59.894] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:59.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:30:0) after 1m0s
[01:04:00.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:30:0)
[01:04:00.031] Timer tick, asking Buildbucket for the build status
[01:04:00.490] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:00.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:31:0) after 1m0s
[01:05:01.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:31:0)
[01:05:01.267] Timer tick, asking Buildbucket for the build status
[01:05:01.448] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:01.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:32:0) after 1m0s
[01:06:01.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:32:0)
[01:06:01.557] Timer tick, asking Buildbucket for the build status
[01:06:01.821] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:01.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:33:0) after 1m0s
[01:07:01.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:33:0)
[01:07:01.886] Timer tick, asking Buildbucket for the build status
[01:07:02.148] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:02.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:34:0) after 1m0s
[01:08:02.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:34:0)
[01:08:02.290] Timer tick, asking Buildbucket for the build status
[01:08:02.499] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:02.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:35:0) after 1m0s
[01:09:02.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:35:0)
[01:09:02.633] Timer tick, asking Buildbucket for the build status
[01:09:02.781] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:02.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:36:0) after 1m0s
[01:10:02.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:36:0)
[01:10:02.959] Timer tick, asking Buildbucket for the build status
[01:10:04.161] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:04.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:37:0) after 1m0s
[01:11:04.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:37:0)
[01:11:04.193] Timer tick, asking Buildbucket for the build status
[01:11:04.391] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:04.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:38:0) after 1m0s
[01:12:04.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:38:0)
[01:12:04.458] Timer tick, asking Buildbucket for the build status
[01:12:04.870] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:04.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:39:0) after 1m0s
[01:13:04.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:39:0)
[01:13:04.947] Timer tick, asking Buildbucket for the build status
[01:13:05.443] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:05.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:40:0) after 1m0s
[01:14:05.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:40:0)
[01:14:05.463] Timer tick, asking Buildbucket for the build status
[01:14:06.024] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:41:0) after 1m0s
[01:15:06.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:41:0)
[01:15:06.113] Timer tick, asking Buildbucket for the build status
[01:15:06.465] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:42:0) after 1m0s
[01:16:06.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:42:0)
[01:16:06.520] Timer tick, asking Buildbucket for the build status
[01:16:06.657] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:43:0) after 1m0s
[01:17:06.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:43:0)
[01:17:06.675] Timer tick, asking Buildbucket for the build status
[01:17:06.893] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:06.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:44:0) after 1m0s
[01:18:06.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:44:0)
[01:18:06.916] Timer tick, asking Buildbucket for the build status
[01:18:07.035] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:45:0) after 1m0s
[01:19:07.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:45:0)
[01:19:07.082] Timer tick, asking Buildbucket for the build status
[01:19:07.318] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:46:0) after 1m0s
[01:20:07.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:46:0)
[01:20:07.350] Timer tick, asking Buildbucket for the build status
[01:20:07.513] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:07.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:47:0) after 1m0s
[01:21:07.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:47:0)
[01:21:07.585] Timer tick, asking Buildbucket for the build status
[01:21:07.719] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:07.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:48:0) after 1m0s
[01:22:07.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:48:0)
[01:22:07.711] Timer tick, asking Buildbucket for the build status
[01:22:07.906] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:07.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:49:0) after 1m0s
[01:23:08.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:49:0)
[01:23:08.176] Timer tick, asking Buildbucket for the build status
[01:23:08.345] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:08.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:50:0) after 1m0s
[01:24:08.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:50:0)
[01:24:08.705] Timer tick, asking Buildbucket for the build status
[01:24:08.961] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:08.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:51:0) after 1m0s
[01:25:09.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:51:0)
[01:25:09.513] Timer tick, asking Buildbucket for the build status
[01:25:09.717] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:09.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:52:0) after 1m0s
[01:26:09.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:52:0)
[01:26:09.909] Timer tick, asking Buildbucket for the build status
[01:26:10.516] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:10.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:53:0) after 1m0s
[01:27:10.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:53:0)
[01:27:10.829] Timer tick, asking Buildbucket for the build status
[01:27:10.915] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:10.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:54:0) after 1m0s
[01:28:11.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:54:0)
[01:28:11.066] Timer tick, asking Buildbucket for the build status
[01:28:11.264] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:11.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:55:0) after 1m0s
[01:29:11.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:55:0)
[01:29:11.272] Timer tick, asking Buildbucket for the build status
[01:29:12.117] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:12.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:56:0) after 1m0s
[01:30:12.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:56:0)
[01:30:12.277] Timer tick, asking Buildbucket for the build status
[01:30:12.764] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:12.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:57:0) after 1m0s
[01:31:13.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:57:0)
[01:31:13.061] Timer tick, asking Buildbucket for the build status
[01:31:13.308] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:13.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:58:0) after 1m0s
[01:32:13.455] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:58:0)
[01:32:13.455] Timer tick, asking Buildbucket for the build status
[01:32:13.664] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:13.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:59:0) after 1m0s
[01:33:13.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:59:0)
[01:33:13.946] Timer tick, asking Buildbucket for the build status
[01:33:14.283] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:14.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:60:0) after 1m0s
[01:34:14.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:60:0)
[01:34:14.388] Timer tick, asking Buildbucket for the build status
[01:34:14.520] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:14.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:61:0) after 1m0s
[01:35:14.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:61:0)
[01:35:14.716] Timer tick, asking Buildbucket for the build status
[01:35:14.942] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:14.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:62:0) after 1m0s
[01:36:14.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:62:0)
[01:36:14.929] Timer tick, asking Buildbucket for the build status
[01:36:15.220] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:15.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:63:0) after 1m0s
[01:37:15.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:63:0)
[01:37:15.244] Timer tick, asking Buildbucket for the build status
[01:37:15.425] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:15.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:64:0) after 1m0s
[01:38:15.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:64:0)
[01:38:15.428] Timer tick, asking Buildbucket for the build status
[01:38:17.122] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:17.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:65:0) after 1m0s
[01:39:17.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:65:0)
[01:39:17.197] Timer tick, asking Buildbucket for the build status
[01:39:17.391] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:17.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:66:0) after 1m0s
[01:40:17.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:66:0)
[01:40:17.464] Timer tick, asking Buildbucket for the build status
[01:40:17.606] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:17.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:67:0) after 1m0s
[01:41:17.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:67:0)
[01:41:17.734] Timer tick, asking Buildbucket for the build status
[01:41:17.910] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:17.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:68:0) after 1m0s
[01:42:17.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:68:0)
[01:42:17.968] Timer tick, asking Buildbucket for the build status
[01:42:18.176] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:18.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:69:0) after 1m0s
[01:43:18.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:69:0)
[01:43:18.286] Timer tick, asking Buildbucket for the build status
[01:43:18.511] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:18.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:70:0) after 1m0s
[01:44:18.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:70:0)
[01:44:18.542] Timer tick, asking Buildbucket for the build status
[01:44:18.728] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:18.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:71:0) after 1m0s
[01:45:18.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:71:0)
[01:45:18.809] Timer tick, asking Buildbucket for the build status
[01:45:19.005] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:19.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:72:0) after 1m0s
[01:46:19.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:72:0)
[01:46:19.044] Timer tick, asking Buildbucket for the build status
[01:46:19.359] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:19.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:73:0) after 1m0s
[01:47:19.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:73:0)
[01:47:19.448] Timer tick, asking Buildbucket for the build status
[01:47:19.689] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:19.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:74:0) after 1m0s
[01:48:19.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:74:0)
[01:48:19.710] Timer tick, asking Buildbucket for the build status
[01:48:20.842] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:20.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:75:0) after 1m0s
[01:49:20.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:75:0)
[01:49:20.980] Timer tick, asking Buildbucket for the build status
[01:49:21.125] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:21.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:76:0) after 1m0s
[01:50:21.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:76:0)
[01:50:21.155] Timer tick, asking Buildbucket for the build status
[01:50:21.425] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:21.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:77:0) after 1m0s
[01:51:21.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:77:0)
[01:51:21.500] Timer tick, asking Buildbucket for the build status
[01:51:23.297] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:23.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:78:0) after 1m0s
[01:52:23.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:78:0)
[01:52:23.357] Timer tick, asking Buildbucket for the build status
[01:52:24.195] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:24.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:79:0) after 1m0s
[01:53:24.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:79:0)
[01:53:24.289] Timer tick, asking Buildbucket for the build status
[01:53:24.461] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:24.462] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:80:0) after 1m0s
[01:54:24.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:80:0)
[01:54:24.632] Timer tick, asking Buildbucket for the build status
[01:54:24.998] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:24.998] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:81:0) after 1m0s
[01:55:25.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:81:0)
[01:55:25.145] Timer tick, asking Buildbucket for the build status
[01:55:25.472] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:25.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:82:0) after 1m0s
[01:56:25.533] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:82:0)
[01:56:25.533] Timer tick, asking Buildbucket for the build status
[01:56:25.692] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:25.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:83:0) after 1m0s
[01:57:25.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:83:0)
[01:57:25.815] Timer tick, asking Buildbucket for the build status
[01:57:25.962] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:25.962] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:84:0) after 1m0s
[01:58:26.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:84:0)
[01:58:26.079] Timer tick, asking Buildbucket for the build status
[01:58:26.192] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:26.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:85:0) after 1m0s
[01:59:26.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:85:0)
[01:59:26.375] Timer tick, asking Buildbucket for the build status
[01:59:26.499] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:26.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:86:0) after 1m0s
[02:00:26.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:86:0)
[02:00:26.636] Timer tick, asking Buildbucket for the build status
[02:00:26.789] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:26.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:87:0) after 1m0s
[02:01:26.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:87:0)
[02:01:26.873] Timer tick, asking Buildbucket for the build status
[02:01:26.995] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:26.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:88:0) after 1m0s
[02:02:26.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:88:0)
[02:02:26.988] Timer tick, asking Buildbucket for the build status
[02:02:27.167] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:27.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:89:0) after 1m0s
[02:03:27.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:89:0)
[02:03:27.228] Timer tick, asking Buildbucket for the build status
[02:03:27.680] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:27.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:90:0) after 1m0s
[02:04:27.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:90:0)
[02:04:27.757] Timer tick, asking Buildbucket for the build status
[02:04:27.884] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:27.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:91:0) after 1m0s
[02:05:28.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:91:0)
[02:05:28.003] Timer tick, asking Buildbucket for the build status
[02:05:28.189] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:28.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:92:0) after 1m0s
[02:06:28.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:92:0)
[02:06:28.181] Timer tick, asking Buildbucket for the build status
[02:06:29.619] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:29.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:93:0) after 1m0s
[02:07:29.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:93:0)
[02:07:29.668] Timer tick, asking Buildbucket for the build status
[02:07:30.035] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:30.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:94:0) after 1m0s
[02:08:30.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:94:0)
[02:08:30.112] Timer tick, asking Buildbucket for the build status
[02:08:30.303] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:30.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:95:0) after 1m0s
[02:09:30.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:95:0)
[02:09:30.346] Timer tick, asking Buildbucket for the build status
[02:09:30.482] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:30.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:96:0) after 1m0s
[02:10:30.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:96:0)
[02:10:30.559] Timer tick, asking Buildbucket for the build status
[02:10:30.840] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:30.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:97:0) after 1m0s
[02:11:30.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:97:0)
[02:11:30.951] Timer tick, asking Buildbucket for the build status
[02:11:31.211] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:31.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:98:0) after 1m0s
[02:12:31.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:98:0)
[02:12:31.260] Timer tick, asking Buildbucket for the build status
[02:12:32.159] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:32.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:99:0) after 1m0s
[02:13:32.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:99:0)
[02:13:32.237] Timer tick, asking Buildbucket for the build status
[02:13:32.905] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:32.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:100:0) after 1m0s
[02:14:33.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:100:0)
[02:14:33.075] Timer tick, asking Buildbucket for the build status
[02:14:33.198] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:33.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:101:0) after 1m0s
[02:15:33.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:101:0)
[02:15:33.306] Timer tick, asking Buildbucket for the build status
[02:15:33.839] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:33.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:102:0) after 1m0s
[02:16:33.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:102:0)
[02:16:33.938] Timer tick, asking Buildbucket for the build status
[02:16:34.535] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:34.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:103:0) after 1m0s
[02:17:34.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:103:0)
[02:17:34.651] Timer tick, asking Buildbucket for the build status
[02:17:34.913] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:34.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:104:0) after 1m0s
[02:18:35.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:104:0)
[02:18:35.048] Timer tick, asking Buildbucket for the build status
[02:18:35.519] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:35.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:105:0) after 1m0s
[02:19:35.649] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:105:0)
[02:19:35.649] Timer tick, asking Buildbucket for the build status
[02:19:36.138] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:36.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:106:0) after 1m0s
[02:20:36.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:106:0)
[02:20:36.233] Timer tick, asking Buildbucket for the build status
[02:20:37.540] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:37.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:107:0) after 1m0s
[02:21:37.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:107:0)
[02:21:37.664] Timer tick, asking Buildbucket for the build status
[02:21:37.848] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:37.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:108:0) after 1m0s
[02:22:37.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:108:0)
[02:22:37.929] Timer tick, asking Buildbucket for the build status
[02:22:38.120] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:38.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:109:0) after 1m0s
[02:23:38.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:109:0)
[02:23:38.245] Timer tick, asking Buildbucket for the build status
[02:23:38.504] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:38.504] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:110:0) after 1m0s
[02:24:38.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:110:0)
[02:24:38.572] Timer tick, asking Buildbucket for the build status
[02:24:38.704] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:38.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:111:0) after 1m0s
[02:25:38.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:111:0)
[02:25:38.752] Timer tick, asking Buildbucket for the build status
[02:25:38.902] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:38.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:112:0) after 1m0s
[02:26:38.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:112:0)
[02:26:38.983] Timer tick, asking Buildbucket for the build status
[02:26:39.227] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:39.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:113:0) after 1m0s
[02:27:39.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:113:0)
[02:27:39.286] Timer tick, asking Buildbucket for the build status
[02:27:39.510] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:39.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:114:0) after 1m0s
[02:28:39.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:114:0)
[02:28:39.510] Timer tick, asking Buildbucket for the build status
[02:28:39.983] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:39.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:115:0) after 1m0s
[02:29:40.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:115:0)
[02:29:40.106] Timer tick, asking Buildbucket for the build status
[02:29:40.619] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:40.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:116:0) after 1m0s
[02:30:40.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:116:0)
[02:30:40.725] Timer tick, asking Buildbucket for the build status
[02:30:40.968] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:40.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:117:0) after 1m0s
[02:31:41.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:117:0)
[02:31:41.057] Timer tick, asking Buildbucket for the build status
[02:31:41.934] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:41.934] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:118:0) after 1m0s
[02:32:42.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:118:0)
[02:32:42.037] Timer tick, asking Buildbucket for the build status
[02:32:42.231] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:42.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:119:0) after 1m0s
[02:33:42.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:119:0)
[02:33:42.351] Timer tick, asking Buildbucket for the build status
[02:33:42.570] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:42.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:120:0) after 1m0s
[02:34:42.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:120:0)
[02:34:42.624] Timer tick, asking Buildbucket for the build status
[02:34:42.779] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:42.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:121:0) after 1m0s
[02:35:42.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:121:0)
[02:35:42.839] Timer tick, asking Buildbucket for the build status
[02:35:42.979] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:42.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:122:0) after 1m0s
[02:36:43.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:122:0)
[02:36:43.065] Timer tick, asking Buildbucket for the build status
[02:36:43.645] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:43.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:123:0) after 1m0s
[02:37:43.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:123:0)
[02:37:43.810] Timer tick, asking Buildbucket for the build status
[02:37:44.092] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:44.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:124:0) after 1m0s
[02:38:44.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:124:0)
[02:38:44.206] Timer tick, asking Buildbucket for the build status
[02:38:44.373] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:125:0) after 1m0s
[02:39:44.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:125:0)
[02:39:44.465] Timer tick, asking Buildbucket for the build status
[02:39:44.738] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:126:0) after 1m0s
[02:40:44.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:126:0)
[02:40:44.865] Timer tick, asking Buildbucket for the build status
[02:40:45.066] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:45.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:127:0) after 1m0s
[02:41:45.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:127:0)
[02:41:45.238] Timer tick, asking Buildbucket for the build status
[02:41:45.618] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:45.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:128:0) after 1m0s
[02:42:45.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:128:0)
[02:42:45.708] Timer tick, asking Buildbucket for the build status
[02:42:45.986] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:45.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:129:0) after 1m0s
[02:43:46.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:129:0)
[02:43:46.048] Timer tick, asking Buildbucket for the build status
[02:43:46.202] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:46.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:130:0) after 1m0s
[02:44:46.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:130:0)
[02:44:46.314] Timer tick, asking Buildbucket for the build status
[02:44:46.659] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:46.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:131:0) after 1m0s
[02:45:46.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:131:0)
[02:45:46.767] Timer tick, asking Buildbucket for the build status
[02:45:46.985] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:46.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:132:0) after 1m0s
[02:46:47.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:132:0)
[02:46:47.036] Timer tick, asking Buildbucket for the build status
[02:46:47.374] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:47.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:133:0) after 1m0s
[02:47:47.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:133:0)
[02:47:47.488] Timer tick, asking Buildbucket for the build status
[02:47:47.868] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:47.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:134:0) after 1m0s
[02:48:48.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:134:0)
[02:48:48.068] Timer tick, asking Buildbucket for the build status
[02:48:48.418] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:48.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:135:0) after 1m0s
[02:49:48.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:135:0)
[02:49:48.506] Timer tick, asking Buildbucket for the build status
[02:49:48.659] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:48.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:136:0) after 1m0s
[02:50:48.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:136:0)
[02:50:48.731] Timer tick, asking Buildbucket for the build status
[02:50:49.129] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:49.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:137:0) after 1m0s
[02:51:50.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:137:0)
[02:51:50.243] Timer tick, asking Buildbucket for the build status
[02:51:51.562] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:51.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:138:0) after 1m0s
[02:52:51.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:138:0)
[02:52:51.551] Timer tick, asking Buildbucket for the build status
[02:52:51.736] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:51.736] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:139:0) after 1m0s
[02:53:51.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:139:0)
[02:53:51.802] Timer tick, asking Buildbucket for the build status
[02:53:52.012] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:52.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:140:0) after 1m0s
[02:54:52.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:140:0)
[02:54:52.069] Timer tick, asking Buildbucket for the build status
[02:54:52.323] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:52.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:141:0) after 1m0s
[02:55:52.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:141:0)
[02:55:52.354] Timer tick, asking Buildbucket for the build status
[02:55:52.528] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:52.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:142:0) after 1m0s
[02:56:52.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:142:0)
[02:56:52.573] Timer tick, asking Buildbucket for the build status
[02:56:53.360] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:53.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:143:0) after 1m0s
[02:57:53.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:143:0)
[02:57:53.389] Timer tick, asking Buildbucket for the build status
[02:57:53.512] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:53.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:144:0) after 1m0s
[02:58:53.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:144:0)
[02:58:53.532] Timer tick, asking Buildbucket for the build status
[02:58:53.827] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:53.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:145:0) after 1m0s
[02:59:53.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:145:0)
[02:59:53.841] Timer tick, asking Buildbucket for the build status
[02:59:54.608] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:54.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:146:0) after 1m0s
[03:00:54.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:146:0)
[03:00:54.699] Timer tick, asking Buildbucket for the build status
[03:00:54.837] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:54.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:147:0) after 1m0s
[03:01:54.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:147:0)
[03:01:54.899] Timer tick, asking Buildbucket for the build status
[03:01:55.112] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:55.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:148:0) after 1m0s
[03:02:55.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:148:0)
[03:02:55.202] Timer tick, asking Buildbucket for the build status
[03:02:55.464] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:55.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:149:0) after 1m0s
[03:03:55.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:149:0)
[03:03:55.517] Timer tick, asking Buildbucket for the build status
[03:03:55.638] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:55.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:150:0) after 1m0s
[03:04:55.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:150:0)
[03:04:55.695] Timer tick, asking Buildbucket for the build status
[03:04:55.914] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:55.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:151:0) after 1m0s
[03:05:55.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:151:0)
[03:05:55.936] Timer tick, asking Buildbucket for the build status
[03:05:56.842] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:56.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:152:0) after 1m0s
[03:06:56.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:152:0)
[03:06:56.933] Timer tick, asking Buildbucket for the build status
[03:06:57.801] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:57.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:153:0) after 1m0s
[03:07:57.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:153:0)
[03:07:57.830] Timer tick, asking Buildbucket for the build status
[03:07:57.971] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:57.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:154:0) after 1m0s
[03:08:58.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:154:0)
[03:08:58.085] Timer tick, asking Buildbucket for the build status
[03:08:58.373] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:58.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:155:0) after 1m0s
[03:09:58.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:155:0)
[03:09:58.553] Timer tick, asking Buildbucket for the build status
[03:09:58.688] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:58.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:156:0) after 1m0s
[03:10:58.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:156:0)
[03:10:58.752] Timer tick, asking Buildbucket for the build status
[03:10:58.883] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:58.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:157:0) after 1m0s
[03:11:58.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:157:0)
[03:11:58.932] Timer tick, asking Buildbucket for the build status
[03:11:59.368] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:59.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:158:0) after 1m0s
[03:12:59.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:158:0)
[03:12:59.499] Timer tick, asking Buildbucket for the build status
[03:12:59.609] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:59.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:159:0) after 1m0s
[03:13:59.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:159:0)
[03:13:59.820] Timer tick, asking Buildbucket for the build status
[03:13:59.955] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:59.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:160:0) after 1m0s
[03:15:00.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:160:0)
[03:15:00.211] Timer tick, asking Buildbucket for the build status
[03:15:00.392] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:00.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:161:0) after 1m0s
[03:16:01.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:161:0)
[03:16:01.144] Timer tick, asking Buildbucket for the build status
[03:16:01.258] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:01.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:162:0) after 1m0s
[03:17:01.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:162:0)
[03:17:01.874] Timer tick, asking Buildbucket for the build status
[03:17:02.230] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:02.230] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:163:0) after 1m0s
[03:18:02.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:163:0)
[03:18:02.469] Timer tick, asking Buildbucket for the build status
[03:18:02.629] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:02.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:164:0) after 1m0s
[03:19:02.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:164:0)
[03:19:02.735] Timer tick, asking Buildbucket for the build status
[03:19:02.867] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:02.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:165:0) after 1m0s
[03:20:02.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:165:0)
[03:20:02.845] Timer tick, asking Buildbucket for the build status
[03:20:03.068] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:03.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:166:0) after 1m0s
[03:21:03.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:166:0)
[03:21:03.156] Timer tick, asking Buildbucket for the build status
[03:21:03.332] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:03.332] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:167:0) after 1m0s
[03:22:03.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:167:0)
[03:22:03.359] Timer tick, asking Buildbucket for the build status
[03:22:04.113] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:04.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:168:0) after 1m0s
[03:23:04.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:168:0)
[03:23:04.251] Timer tick, asking Buildbucket for the build status
[03:23:04.399] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:04.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:169:0) after 1m0s
[03:24:04.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:169:0)
[03:24:04.408] Timer tick, asking Buildbucket for the build status
[03:24:04.624] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:04.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:170:0) after 1m0s
[03:25:04.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:170:0)
[03:25:04.647] Timer tick, asking Buildbucket for the build status
[03:25:04.831] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:04.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:171:0) after 1m0s
[03:26:04.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:171:0)
[03:26:04.870] Timer tick, asking Buildbucket for the build status
[03:26:04.996] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:04.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:172:0) after 1m0s
[03:27:05.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:172:0)
[03:27:05.120] Timer tick, asking Buildbucket for the build status
[03:27:05.463] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:05.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:173:0) after 1m0s
[03:28:05.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:173:0)
[03:28:05.605] Timer tick, asking Buildbucket for the build status
[03:28:05.761] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:05.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:174:0) after 1m0s
[03:29:05.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:174:0)
[03:29:05.896] Timer tick, asking Buildbucket for the build status
[03:29:06.387] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:06.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:175:0) after 1m0s
[03:30:06.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:175:0)
[03:30:06.535] Timer tick, asking Buildbucket for the build status
[03:30:06.704] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:06.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:176:0) after 1m0s
[03:31:07.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:176:0)
[03:31:07.349] Timer tick, asking Buildbucket for the build status
[03:31:07.667] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:07.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:177:0) after 1m0s
[03:32:07.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:177:0)
[03:32:07.875] Timer tick, asking Buildbucket for the build status
[03:32:08.002] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:08.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:178:0) after 1m0s
[03:33:08.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:178:0)
[03:33:08.175] Timer tick, asking Buildbucket for the build status
[03:33:08.329] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:08.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:179:0) after 1m0s
[03:34:08.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:179:0)
[03:34:08.639] Timer tick, asking Buildbucket for the build status
[03:34:08.775] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:08.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:180:0) after 1m0s
[03:35:09.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:180:0)
[03:35:09.139] Timer tick, asking Buildbucket for the build status
[03:35:09.298] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:09.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:181:0) after 1m0s
[03:36:09.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:181:0)
[03:36:09.380] Timer tick, asking Buildbucket for the build status
[03:36:09.507] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:09.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:182:0) after 1m0s
[03:37:09.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:182:0)
[03:37:09.790] Timer tick, asking Buildbucket for the build status
[03:37:09.974] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:09.974] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:183:0) after 1m0s
[03:38:10.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:183:0)
[03:38:10.113] Timer tick, asking Buildbucket for the build status
[03:38:10.388] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:10.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:184:0) after 1m0s
[03:39:10.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:184:0)
[03:39:10.428] Timer tick, asking Buildbucket for the build status
[03:39:10.883] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:10.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:185:0) after 1m0s
[03:40:10.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:185:0)
[03:40:10.994] Timer tick, asking Buildbucket for the build status
[03:40:11.162] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:11.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:186:0) after 1m0s
[03:41:11.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:186:0)
[03:41:11.187] Timer tick, asking Buildbucket for the build status
[03:41:11.344] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:11.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:187:0) after 1m0s
[03:42:11.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:187:0)
[03:42:11.829] Timer tick, asking Buildbucket for the build status
[03:42:12.104] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:12.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:188:0) after 1m0s
[03:43:12.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:188:0)
[03:43:12.796] Timer tick, asking Buildbucket for the build status
[03:43:12.949] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:12.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:189:0) after 1m0s
[03:44:13.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:189:0)
[03:44:13.036] Timer tick, asking Buildbucket for the build status
[03:44:13.171] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:13.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:190:0) after 1m0s
[03:45:13.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:190:0)
[03:45:13.254] Timer tick, asking Buildbucket for the build status
[03:45:13.390] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:13.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:191:0) after 1m0s
[03:46:13.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:191:0)
[03:46:13.415] Timer tick, asking Buildbucket for the build status
[03:46:14.036] Build 8877832953997360944: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:14.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9043263016002527152:192:0) after 1m0s
[03:46:59.692] Received PubSub notification, asking Buildbucket for the build status
[03:46:59.838] Build 8877832953997360944: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:46:59.838] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1591847218674836",
    "created_by": "project:infra",
    "created_ts": "1591835748635906",
    "id": "8877832953997360944",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4168.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"e41ed997-5bc4-4a04-867f-694ae1088dda\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4168.3\"}}",
    "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-g4pg\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5190-b7dcd03\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1591835781895974",
    "status": "COMPLETED",
    "status_changed_ts": "1591847219208780",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9043263016002527152",
      "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/8877832953997360944/+/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:4cb99f7e2d88b410",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1591847219265981",
    "url": "https://ci.chromium.org/b/8877832953997360944",
    "utcnow_ts": "1591847219824447"
  }
}
[03:46:59.838] Invocation finished in 3h11m12.4989542s with status SUCCEEDED