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

• parent_buildername:publish_tarball
• user_agent:recipe

[23:13:54.243] New invocation is queued and will start shortly
[23:13:54.243] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:13:55.428] Starting the invocation (attempt 1)
[23:13:55.485] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:13:55.485] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:13:55.485] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9042452795079046224",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4177.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d01fd28f-268e-4184-90a1-0e8b87423c4f\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4177.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:9042452795079046224",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[23:13:55.945] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1592608435587057",
    "id": "8877022733004014048",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4177.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d01fd28f-268e-4184-90a1-0e8b87423c4f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4177.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1592608435781351",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042452795079046224",
      "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/8877022733004014048/+/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": "1592608435781470",
    "url": "https://ci.chromium.org/b/8877022733004014048",
    "utcnow_ts": "1592608435934501"
  }
}
[23:13:55.945] Task URL: https://ci.chromium.org/b/8877022733004014048
[23:13:55.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:2:0) after 1m0s
[23:14:25.413] Received PubSub notification, asking Buildbucket for the build status
[23:14:25.506] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:55.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:2:0)
[23:14:55.965] Timer tick, asking Buildbucket for the build status
[23:14:56.083] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:56.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:4:0) after 1m0s
[23:15:56.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:4:0)
[23:15:56.126] Timer tick, asking Buildbucket for the build status
[23:15:56.268] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:56.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:5:0) after 1m0s
[23:16:56.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:5:0)
[23:16:56.288] Timer tick, asking Buildbucket for the build status
[23:16:56.471] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:56.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:6:0) after 1m0s
[23:17:56.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:6:0)
[23:17:56.489] Timer tick, asking Buildbucket for the build status
[23:17:56.636] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:56.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:7:0) after 1m0s
[23:18:56.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:7:0)
[23:18:56.686] Timer tick, asking Buildbucket for the build status
[23:18:58.834] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:58.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:8:0) after 1m0s
[23:19:58.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:8:0)
[23:19:58.859] Timer tick, asking Buildbucket for the build status
[23:19:59.302] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:59.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:9:0) after 1m0s
[23:20:59.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:9:0)
[23:20:59.431] Timer tick, asking Buildbucket for the build status
[23:20:59.518] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:59.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:10:0) after 1m0s
[23:21:59.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:10:0)
[23:21:59.583] Timer tick, asking Buildbucket for the build status
[23:21:59.688] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:59.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:11:0) after 1m0s
[23:22:59.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:11:0)
[23:22:59.845] Timer tick, asking Buildbucket for the build status
[23:23:00.233] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:00.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:12:0) after 1m0s
[23:24:00.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:12:0)
[23:24:00.487] Timer tick, asking Buildbucket for the build status
[23:24:00.721] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:00.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:13:0) after 1m0s
[23:25:01.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:13:0)
[23:25:01.041] Timer tick, asking Buildbucket for the build status
[23:25:01.208] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:01.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:14:0) after 1m0s
[23:26:02.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:14:0)
[23:26:02.015] Timer tick, asking Buildbucket for the build status
[23:26:02.146] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:02.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:15:0) after 1m0s
[23:27:02.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:15:0)
[23:27:02.175] Timer tick, asking Buildbucket for the build status
[23:27:02.286] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:02.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:16:0) after 1m0s
[23:28:02.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:16:0)
[23:28:02.927] Timer tick, asking Buildbucket for the build status
[23:28:03.521] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:03.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:17:0) after 1m0s
[23:29:03.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:17:0)
[23:29:03.591] Timer tick, asking Buildbucket for the build status
[23:29:03.770] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:03.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:18:0) after 1m0s
[23:30:03.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:18:0)
[23:30:03.815] Timer tick, asking Buildbucket for the build status
[23:30:04.082] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:04.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:19:0) after 1m0s
[23:31:04.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:19:0)
[23:31:04.128] Timer tick, asking Buildbucket for the build status
[23:31:04.461] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:04.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:20:0) after 1m0s
[23:32:04.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:20:0)
[23:32:04.460] Timer tick, asking Buildbucket for the build status
[23:32:04.623] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:04.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:21:0) after 1m0s
[23:33:04.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:21:0)
[23:33:04.655] Timer tick, asking Buildbucket for the build status
[23:33:04.800] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:04.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:22:0) after 1m0s
[23:34:04.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:22:0)
[23:34:04.834] Timer tick, asking Buildbucket for the build status
[23:34:05.511] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:05.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:23:0) after 1m0s
[23:35:05.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:23:0)
[23:35:05.552] Timer tick, asking Buildbucket for the build status
[23:35:05.697] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:05.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:24:0) after 1m0s
[23:36:05.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:24:0)
[23:36:05.736] Timer tick, asking Buildbucket for the build status
[23:36:06.063] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:06.063] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:25:0) after 1m0s
[23:37:06.097] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:25:0)
[23:37:06.097] Timer tick, asking Buildbucket for the build status
[23:37:06.389] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:06.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:26:0) after 1m0s
[23:38:06.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:26:0)
[23:38:06.414] Timer tick, asking Buildbucket for the build status
[23:38:06.620] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:06.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:27:0) after 1m0s
[23:39:06.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:27:0)
[23:39:06.645] Timer tick, asking Buildbucket for the build status
[23:39:07.199] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:07.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:28:0) after 1m0s
[23:40:07.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:28:0)
[23:40:07.184] Timer tick, asking Buildbucket for the build status
[23:40:07.592] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:07.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:29:0) after 1m0s
[23:41:07.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:29:0)
[23:41:07.593] Timer tick, asking Buildbucket for the build status
[23:41:07.790] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:07.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:30:0) after 1m0s
[23:42:07.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:30:0)
[23:42:07.797] Timer tick, asking Buildbucket for the build status
[23:42:08.945] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:08.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:31:0) after 1m0s
[23:43:09.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:31:0)
[23:43:09.055] Timer tick, asking Buildbucket for the build status
[23:43:09.218] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:09.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:32:0) after 1m0s
[23:44:09.307] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:32:0)
[23:44:09.307] Timer tick, asking Buildbucket for the build status
[23:44:09.493] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:09.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:33:0) after 1m0s
[23:45:09.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:33:0)
[23:45:09.607] Timer tick, asking Buildbucket for the build status
[23:45:09.750] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:09.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:34:0) after 1m0s
[23:46:09.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:34:0)
[23:46:09.787] Timer tick, asking Buildbucket for the build status
[23:46:09.919] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:09.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:35:0) after 1m0s
[23:47:09.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:35:0)
[23:47:09.937] Timer tick, asking Buildbucket for the build status
[23:47:10.169] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:10.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:36:0) after 1m0s
[23:48:10.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:36:0)
[23:48:10.206] Timer tick, asking Buildbucket for the build status
[23:48:10.650] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:10.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:37:0) after 1m0s
[23:49:10.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:37:0)
[23:49:10.683] Timer tick, asking Buildbucket for the build status
[23:49:11.076] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:11.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:38:0) after 1m0s
[23:50:11.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:38:0)
[23:50:11.132] Timer tick, asking Buildbucket for the build status
[23:50:11.254] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:11.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:39:0) after 1m0s
[23:51:11.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:39:0)
[23:51:11.333] Timer tick, asking Buildbucket for the build status
[23:51:11.623] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:11.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:40:0) after 1m0s
[23:52:11.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:40:0)
[23:52:11.710] Timer tick, asking Buildbucket for the build status
[23:52:11.904] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:11.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:41:0) after 1m0s
[23:53:11.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:41:0)
[23:53:11.920] Timer tick, asking Buildbucket for the build status
[23:53:12.265] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:12.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:42:0) after 1m0s
[23:54:12.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:42:0)
[23:54:12.276] Timer tick, asking Buildbucket for the build status
[23:54:12.469] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:12.469] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:43:0) after 1m0s
[23:55:12.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:43:0)
[23:55:12.494] Timer tick, asking Buildbucket for the build status
[23:55:12.693] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:12.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:44:0) after 1m0s
[23:56:12.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:44:0)
[23:56:12.756] Timer tick, asking Buildbucket for the build status
[23:56:13.399] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:13.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:45:0) after 1m0s
[23:57:13.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:45:0)
[23:57:13.518] Timer tick, asking Buildbucket for the build status
[23:57:13.680] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:13.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:46:0) after 1m0s
[23:58:13.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:46:0)
[23:58:13.696] Timer tick, asking Buildbucket for the build status
[23:58:14.042] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:14.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:47:0) after 1m0s
[23:59:14.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:47:0)
[23:59:14.070] Timer tick, asking Buildbucket for the build status
[23:59:14.266] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:14.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:48:0) after 1m0s
[00:00:14.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:48:0)
[00:00:14.320] Timer tick, asking Buildbucket for the build status
[00:00:14.529] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:14.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:49:0) after 1m0s
[00:01:14.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:49:0)
[00:01:14.623] Timer tick, asking Buildbucket for the build status
[00:01:14.777] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:14.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:50:0) after 1m0s
[00:02:14.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:50:0)
[00:02:14.764] Timer tick, asking Buildbucket for the build status
[00:02:14.910] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:14.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:51:0) after 1m0s
[00:03:14.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:51:0)
[00:03:14.925] Timer tick, asking Buildbucket for the build status
[00:03:15.059] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:15.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:52:0) after 1m0s
[00:04:15.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:52:0)
[00:04:15.070] Timer tick, asking Buildbucket for the build status
[00:04:16.226] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:16.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:53:0) after 1m0s
[00:05:16.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:53:0)
[00:05:16.254] Timer tick, asking Buildbucket for the build status
[00:05:16.386] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:16.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:54:0) after 1m0s
[00:06:16.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:54:0)
[00:06:16.408] Timer tick, asking Buildbucket for the build status
[00:06:16.553] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:16.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:55:0) after 1m0s
[00:07:16.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:55:0)
[00:07:16.586] Timer tick, asking Buildbucket for the build status
[00:07:16.738] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:16.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:56:0) after 1m0s
[00:08:17.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:56:0)
[00:08:17.096] Timer tick, asking Buildbucket for the build status
[00:08:17.223] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:17.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:57:0) after 1m0s
[00:09:17.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:57:0)
[00:09:17.407] Timer tick, asking Buildbucket for the build status
[00:09:17.643] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:17.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:58:0) after 1m0s
[00:10:18.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:58:0)
[00:10:18.202] Timer tick, asking Buildbucket for the build status
[00:10:18.365] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:18.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:59:0) after 1m0s
[00:11:18.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:59:0)
[00:11:18.445] Timer tick, asking Buildbucket for the build status
[00:11:18.692] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:18.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:60:0) after 1m0s
[00:12:18.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:60:0)
[00:12:18.729] Timer tick, asking Buildbucket for the build status
[00:12:18.842] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:18.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:61:0) after 1m0s
[00:13:19.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:61:0)
[00:13:19.142] Timer tick, asking Buildbucket for the build status
[00:13:20.131] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:20.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:62:0) after 1m0s
[00:14:20.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:62:0)
[00:14:20.348] Timer tick, asking Buildbucket for the build status
[00:14:20.491] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:20.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:63:0) after 1m0s
[00:15:20.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:63:0)
[00:15:20.545] Timer tick, asking Buildbucket for the build status
[00:15:21.128] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:21.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:64:0) after 1m0s
[00:16:21.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:64:0)
[00:16:21.301] Timer tick, asking Buildbucket for the build status
[00:16:21.488] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:21.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:65:0) after 1m0s
[00:17:21.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:65:0)
[00:17:21.515] Timer tick, asking Buildbucket for the build status
[00:17:21.677] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:21.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:66:0) after 1m0s
[00:18:21.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:66:0)
[00:18:21.745] Timer tick, asking Buildbucket for the build status
[00:18:22.304] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:22.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:67:0) after 1m0s
[00:19:22.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:67:0)
[00:19:22.311] Timer tick, asking Buildbucket for the build status
[00:19:22.442] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:22.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:68:0) after 1m0s
[00:20:22.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:68:0)
[00:20:22.467] Timer tick, asking Buildbucket for the build status
[00:20:22.628] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:22.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:69:0) after 1m0s
[00:21:22.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:69:0)
[00:21:22.737] Timer tick, asking Buildbucket for the build status
[00:21:23.128] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:23.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:70:0) after 1m0s
[00:22:23.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:70:0)
[00:22:23.175] Timer tick, asking Buildbucket for the build status
[00:22:23.290] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:23.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:71:0) after 1m0s
[00:23:23.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:71:0)
[00:23:23.340] Timer tick, asking Buildbucket for the build status
[00:23:23.524] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:23.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:72:0) after 1m0s
[00:24:23.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:72:0)
[00:24:23.629] Timer tick, asking Buildbucket for the build status
[00:24:24.102] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:24.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:73:0) after 1m0s
[00:25:24.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:73:0)
[00:25:24.119] Timer tick, asking Buildbucket for the build status
[00:25:24.240] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:24.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:74:0) after 1m0s
[00:26:24.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:74:0)
[00:26:24.466] Timer tick, asking Buildbucket for the build status
[00:26:24.682] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:24.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:75:0) after 1m0s
[00:27:24.942] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:75:0)
[00:27:24.942] Timer tick, asking Buildbucket for the build status
[00:27:25.353] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:25.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:76:0) after 1m0s
[00:28:25.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:76:0)
[00:28:25.592] Timer tick, asking Buildbucket for the build status
[00:28:26.323] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:26.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:77:0) after 1m0s
[00:29:26.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:77:0)
[00:29:26.362] Timer tick, asking Buildbucket for the build status
[00:29:26.495] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:26.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:78:0) after 1m0s
[00:30:26.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:78:0)
[00:30:26.580] Timer tick, asking Buildbucket for the build status
[00:30:28.043] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:28.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:79:0) after 1m0s
[00:31:28.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:79:0)
[00:31:28.104] Timer tick, asking Buildbucket for the build status
[00:31:28.982] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:28.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:80:0) after 1m0s
[00:32:29.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:80:0)
[00:32:29.065] Timer tick, asking Buildbucket for the build status
[00:32:29.386] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:29.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:81:0) after 1m0s
[00:33:29.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:81:0)
[00:33:29.385] Timer tick, asking Buildbucket for the build status
[00:33:31.058] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:31.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:82:0) after 1m0s
[00:34:31.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:82:0)
[00:34:31.077] Timer tick, asking Buildbucket for the build status
[00:34:31.227] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:31.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:83:0) after 1m0s
[00:35:31.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:83:0)
[00:35:31.232] Timer tick, asking Buildbucket for the build status
[00:35:31.400] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:84:0) after 1m0s
[00:36:31.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:84:0)
[00:36:31.439] Timer tick, asking Buildbucket for the build status
[00:36:31.600] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:31.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:85:0) after 1m0s
[00:37:31.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:85:0)
[00:37:31.621] Timer tick, asking Buildbucket for the build status
[00:37:31.811] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:31.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:86:0) after 1m0s
[00:38:31.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:86:0)
[00:38:31.853] Timer tick, asking Buildbucket for the build status
[00:38:33.046] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:33.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:87:0) after 1m0s
[00:39:33.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:87:0)
[00:39:33.141] Timer tick, asking Buildbucket for the build status
[00:39:33.523] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:33.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:88:0) after 1m0s
[00:40:33.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:88:0)
[00:40:33.645] Timer tick, asking Buildbucket for the build status
[00:40:33.811] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:33.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:89:0) after 1m0s
[00:41:33.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:89:0)
[00:41:33.868] Timer tick, asking Buildbucket for the build status
[00:41:34.004] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:34.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:90:0) after 1m0s
[00:42:34.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:90:0)
[00:42:34.070] Timer tick, asking Buildbucket for the build status
[00:42:34.242] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:34.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:91:0) after 1m0s
[00:43:34.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:91:0)
[00:43:34.344] Timer tick, asking Buildbucket for the build status
[00:43:35.345] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:35.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:92:0) after 1m0s
[00:44:35.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:92:0)
[00:44:35.379] Timer tick, asking Buildbucket for the build status
[00:44:35.512] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:35.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:93:0) after 1m0s
[00:45:35.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:93:0)
[00:45:35.586] Timer tick, asking Buildbucket for the build status
[00:45:36.453] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:36.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:94:0) after 1m0s
[00:46:36.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:94:0)
[00:46:36.511] Timer tick, asking Buildbucket for the build status
[00:46:36.645] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:36.645] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:95:0) after 1m0s
[00:47:36.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:95:0)
[00:47:36.672] Timer tick, asking Buildbucket for the build status
[00:47:37.079] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:37.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:96:0) after 1m0s
[00:48:37.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:96:0)
[00:48:37.121] Timer tick, asking Buildbucket for the build status
[00:48:41.694] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:41.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:97:0) after 1m0s
[00:49:41.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:97:0)
[00:49:41.716] Timer tick, asking Buildbucket for the build status
[00:49:41.816] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:41.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:98:0) after 1m0s
[00:50:41.894] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:98:0)
[00:50:41.894] Timer tick, asking Buildbucket for the build status
[00:50:42.263] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:42.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:99:0) after 1m0s
[00:51:42.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:99:0)
[00:51:42.309] Timer tick, asking Buildbucket for the build status
[00:51:42.477] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:42.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:100:0) after 1m0s
[00:52:42.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:100:0)
[00:52:42.574] Timer tick, asking Buildbucket for the build status
[00:52:42.722] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:42.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:101:0) after 1m0s
[00:53:42.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:101:0)
[00:53:42.788] Timer tick, asking Buildbucket for the build status
[00:53:43.508] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:43.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:102:0) after 1m0s
[00:54:43.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:102:0)
[00:54:43.548] Timer tick, asking Buildbucket for the build status
[00:54:43.712] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:43.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:103:0) after 1m0s
[00:55:43.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:103:0)
[00:55:43.746] Timer tick, asking Buildbucket for the build status
[00:55:43.982] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:43.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:104:0) after 1m0s
[00:56:44.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:104:0)
[00:56:44.004] Timer tick, asking Buildbucket for the build status
[00:56:44.231] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:44.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:105:0) after 1m0s
[00:57:44.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:105:0)
[00:57:44.361] Timer tick, asking Buildbucket for the build status
[00:57:44.499] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:44.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:106:0) after 1m0s
[00:58:44.552] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:106:0)
[00:58:44.552] Timer tick, asking Buildbucket for the build status
[00:58:44.872] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:44.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:107:0) after 1m0s
[00:59:44.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:107:0)
[00:59:44.950] Timer tick, asking Buildbucket for the build status
[00:59:45.113] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:45.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:108:0) after 1m0s
[01:00:45.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:108:0)
[01:00:45.169] Timer tick, asking Buildbucket for the build status
[01:00:45.932] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:45.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:109:0) after 1m0s
[01:01:45.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:109:0)
[01:01:45.956] Timer tick, asking Buildbucket for the build status
[01:01:46.091] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:46.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:110:0) after 1m0s
[01:02:46.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:110:0)
[01:02:46.147] Timer tick, asking Buildbucket for the build status
[01:02:46.384] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:46.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:111:0) after 1m0s
[01:03:46.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:111:0)
[01:03:46.407] Timer tick, asking Buildbucket for the build status
[01:03:46.612] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:46.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:112:0) after 1m0s
[01:04:46.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:112:0)
[01:04:46.632] Timer tick, asking Buildbucket for the build status
[01:04:47.696] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:47.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:113:0) after 1m0s
[01:05:47.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:113:0)
[01:05:47.737] Timer tick, asking Buildbucket for the build status
[01:05:47.838] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:47.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:114:0) after 1m0s
[01:06:47.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:114:0)
[01:06:47.846] Timer tick, asking Buildbucket for the build status
[01:06:48.022] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:48.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:115:0) after 1m0s
[01:07:48.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:115:0)
[01:07:48.133] Timer tick, asking Buildbucket for the build status
[01:07:49.143] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:49.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:116:0) after 1m0s
[01:08:49.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:116:0)
[01:08:49.204] Timer tick, asking Buildbucket for the build status
[01:08:53.691] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:53.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:117:0) after 1m0s
[01:09:53.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:117:0)
[01:09:53.743] Timer tick, asking Buildbucket for the build status
[01:09:54.092] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:54.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:118:0) after 1m0s
[01:10:54.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:118:0)
[01:10:54.109] Timer tick, asking Buildbucket for the build status
[01:10:54.267] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:54.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:119:0) after 1m0s
[01:11:54.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:119:0)
[01:11:54.290] Timer tick, asking Buildbucket for the build status
[01:11:54.502] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:54.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:120:0) after 1m0s
[01:12:54.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:120:0)
[01:12:54.557] Timer tick, asking Buildbucket for the build status
[01:12:54.763] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:54.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:121:0) after 1m0s
[01:13:54.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:121:0)
[01:13:54.842] Timer tick, asking Buildbucket for the build status
[01:13:55.117] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:55.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:122:0) after 1m0s
[01:14:55.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:122:0)
[01:14:55.185] Timer tick, asking Buildbucket for the build status
[01:14:55.346] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:55.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:123:0) after 1m0s
[01:15:55.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:123:0)
[01:15:55.461] Timer tick, asking Buildbucket for the build status
[01:15:55.768] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:55.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:124:0) after 1m0s
[01:16:55.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:124:0)
[01:16:55.846] Timer tick, asking Buildbucket for the build status
[01:16:56.228] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:56.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:125:0) after 1m0s
[01:17:56.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:125:0)
[01:17:56.325] Timer tick, asking Buildbucket for the build status
[01:17:56.560] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:56.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:126:0) after 1m0s
[01:18:56.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:126:0)
[01:18:56.553] Timer tick, asking Buildbucket for the build status
[01:18:56.755] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:56.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:127:0) after 1m0s
[01:19:56.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:127:0)
[01:19:56.800] Timer tick, asking Buildbucket for the build status
[01:19:57.094] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:57.094] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:128:0) after 1m0s
[01:20:57.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:128:0)
[01:20:57.211] Timer tick, asking Buildbucket for the build status
[01:20:57.655] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:57.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:129:0) after 1m0s
[01:21:57.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:129:0)
[01:21:57.817] Timer tick, asking Buildbucket for the build status
[01:21:58.024] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:58.024] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:130:0) after 1m0s
[01:22:58.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:130:0)
[01:22:58.165] Timer tick, asking Buildbucket for the build status
[01:22:58.342] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:58.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:131:0) after 1m0s
[01:23:58.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:131:0)
[01:23:58.466] Timer tick, asking Buildbucket for the build status
[01:24:00.483] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:00.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:132:0) after 1m0s
[01:25:00.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:132:0)
[01:25:00.718] Timer tick, asking Buildbucket for the build status
[01:25:00.854] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:00.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:133:0) after 1m0s
[01:26:01.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:133:0)
[01:26:01.043] Timer tick, asking Buildbucket for the build status
[01:26:01.309] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:01.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:134:0) after 1m0s
[01:27:01.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:134:0)
[01:27:01.909] Timer tick, asking Buildbucket for the build status
[01:27:02.065] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:02.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:135:0) after 1m0s
[01:28:02.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:135:0)
[01:28:02.322] Timer tick, asking Buildbucket for the build status
[01:28:03.071] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:03.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:136:0) after 1m0s
[01:29:03.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:136:0)
[01:29:03.078] Timer tick, asking Buildbucket for the build status
[01:29:05.751] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:05.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:137:0) after 1m0s
[01:30:05.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:137:0)
[01:30:05.859] Timer tick, asking Buildbucket for the build status
[01:30:06.261] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:06.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:138:0) after 1m0s
[01:31:06.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:138:0)
[01:31:06.286] Timer tick, asking Buildbucket for the build status
[01:31:07.176] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:07.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:139:0) after 1m0s
[01:32:07.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:139:0)
[01:32:07.296] Timer tick, asking Buildbucket for the build status
[01:32:07.691] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:07.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:140:0) after 1m0s
[01:33:07.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:140:0)
[01:33:07.718] Timer tick, asking Buildbucket for the build status
[01:33:08.097] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:08.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:141:0) after 1m0s
[01:34:08.133] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:141:0)
[01:34:08.133] Timer tick, asking Buildbucket for the build status
[01:34:08.704] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:08.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:142:0) after 1m0s
[01:35:08.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:142:0)
[01:35:08.761] Timer tick, asking Buildbucket for the build status
[01:35:09.272] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:09.272] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:143:0) after 1m0s
[01:36:09.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:143:0)
[01:36:09.300] Timer tick, asking Buildbucket for the build status
[01:36:09.494] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:09.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:144:0) after 1m0s
[01:37:09.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:144:0)
[01:37:09.539] Timer tick, asking Buildbucket for the build status
[01:37:09.751] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:09.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:145:0) after 1m0s
[01:38:09.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:145:0)
[01:38:09.913] Timer tick, asking Buildbucket for the build status
[01:38:10.101] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:10.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:146:0) after 1m0s
[01:39:10.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:146:0)
[01:39:10.139] Timer tick, asking Buildbucket for the build status
[01:39:10.331] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:10.331] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:147:0) after 1m0s
[01:40:10.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:147:0)
[01:40:10.369] Timer tick, asking Buildbucket for the build status
[01:40:10.816] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:10.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:148:0) after 1m0s
[01:41:10.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:148:0)
[01:41:10.795] Timer tick, asking Buildbucket for the build status
[01:41:10.944] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:10.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:149:0) after 1m0s
[01:42:11.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:149:0)
[01:42:11.039] Timer tick, asking Buildbucket for the build status
[01:42:11.765] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:11.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:150:0) after 1m0s
[01:43:11.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:150:0)
[01:43:11.823] Timer tick, asking Buildbucket for the build status
[01:43:12.202] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:12.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:151:0) after 1m0s
[01:44:12.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:151:0)
[01:44:12.273] Timer tick, asking Buildbucket for the build status
[01:44:12.391] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:12.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:152:0) after 1m0s
[01:45:12.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:152:0)
[01:45:12.485] Timer tick, asking Buildbucket for the build status
[01:45:12.819] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:12.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:153:0) after 1m0s
[01:46:12.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:153:0)
[01:46:12.839] Timer tick, asking Buildbucket for the build status
[01:46:13.072] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:13.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:154:0) after 1m0s
[01:47:13.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:154:0)
[01:47:13.091] Timer tick, asking Buildbucket for the build status
[01:47:13.542] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:13.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:155:0) after 1m0s
[01:48:13.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:155:0)
[01:48:13.573] Timer tick, asking Buildbucket for the build status
[01:48:13.731] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:13.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:156:0) after 1m0s
[01:49:13.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:156:0)
[01:49:13.783] Timer tick, asking Buildbucket for the build status
[01:49:13.913] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:13.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:157:0) after 1m0s
[01:50:13.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:157:0)
[01:50:13.945] Timer tick, asking Buildbucket for the build status
[01:50:14.206] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:14.206] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:158:0) after 1m0s
[01:51:14.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:158:0)
[01:51:14.195] Timer tick, asking Buildbucket for the build status
[01:51:15.406] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:15.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:159:0) after 1m0s
[01:52:15.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:159:0)
[01:52:15.485] Timer tick, asking Buildbucket for the build status
[01:52:15.637] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:15.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:160:0) after 1m0s
[01:53:15.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:160:0)
[01:53:15.702] Timer tick, asking Buildbucket for the build status
[01:53:15.842] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:15.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:161:0) after 1m0s
[01:54:15.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:161:0)
[01:54:15.862] Timer tick, asking Buildbucket for the build status
[01:54:16.167] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:16.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:162:0) after 1m0s
[01:55:16.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:162:0)
[01:55:16.262] Timer tick, asking Buildbucket for the build status
[01:55:16.541] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:16.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:163:0) after 1m0s
[01:56:16.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:163:0)
[01:56:16.608] Timer tick, asking Buildbucket for the build status
[01:56:16.767] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:16.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:164:0) after 1m0s
[01:57:16.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:164:0)
[01:57:16.793] Timer tick, asking Buildbucket for the build status
[01:57:17.202] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:17.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:165:0) after 1m0s
[01:58:17.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:165:0)
[01:58:17.265] Timer tick, asking Buildbucket for the build status
[01:58:17.997] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:17.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:166:0) after 1m0s
[01:59:18.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:166:0)
[01:59:18.022] Timer tick, asking Buildbucket for the build status
[01:59:18.167] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:18.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:167:0) after 1m0s
[02:00:18.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:167:0)
[02:00:18.150] Timer tick, asking Buildbucket for the build status
[02:00:18.336] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:18.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:168:0) after 1m0s
[02:01:18.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:168:0)
[02:01:18.489] Timer tick, asking Buildbucket for the build status
[02:01:18.649] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:18.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:169:0) after 1m0s
[02:02:18.734] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:169:0)
[02:02:18.734] Timer tick, asking Buildbucket for the build status
[02:02:18.917] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:18.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:170:0) after 1m0s
[02:03:18.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:170:0)
[02:03:18.937] Timer tick, asking Buildbucket for the build status
[02:03:19.159] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:19.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:171:0) after 1m0s
[02:04:19.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:171:0)
[02:04:19.281] Timer tick, asking Buildbucket for the build status
[02:04:19.457] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:19.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:172:0) after 1m0s
[02:05:19.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:172:0)
[02:05:19.617] Timer tick, asking Buildbucket for the build status
[02:05:19.833] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:19.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:173:0) after 1m0s
[02:06:19.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:173:0)
[02:06:19.861] Timer tick, asking Buildbucket for the build status
[02:06:20.118] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:20.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:174:0) after 1m0s
[02:07:20.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:174:0)
[02:07:20.199] Timer tick, asking Buildbucket for the build status
[02:07:20.360] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:20.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:175:0) after 1m0s
[02:08:20.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:175:0)
[02:08:20.410] Timer tick, asking Buildbucket for the build status
[02:08:20.673] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:20.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:176:0) after 1m0s
[02:09:20.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:176:0)
[02:09:20.720] Timer tick, asking Buildbucket for the build status
[02:09:21.009] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:21.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:177:0) after 1m0s
[02:10:21.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:177:0)
[02:10:21.124] Timer tick, asking Buildbucket for the build status
[02:10:21.293] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:21.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:178:0) after 1m0s
[02:11:21.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:178:0)
[02:11:21.338] Timer tick, asking Buildbucket for the build status
[02:11:21.521] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:21.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:179:0) after 1m0s
[02:12:21.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:179:0)
[02:12:21.996] Timer tick, asking Buildbucket for the build status
[02:12:22.298] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:22.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:180:0) after 1m0s
[02:13:22.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:180:0)
[02:13:22.538] Timer tick, asking Buildbucket for the build status
[02:13:23.482] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:23.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:181:0) after 1m0s
[02:14:23.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:181:0)
[02:14:23.591] Timer tick, asking Buildbucket for the build status
[02:14:23.744] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:23.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:182:0) after 1m0s
[02:15:23.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:182:0)
[02:15:23.826] Timer tick, asking Buildbucket for the build status
[02:15:23.965] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:23.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:183:0) after 1m0s
[02:16:24.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:183:0)
[02:16:24.045] Timer tick, asking Buildbucket for the build status
[02:16:24.283] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:24.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:184:0) after 1m0s
[02:17:24.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:184:0)
[02:17:24.357] Timer tick, asking Buildbucket for the build status
[02:17:24.750] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:24.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:185:0) after 1m0s
[02:18:24.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:185:0)
[02:18:24.810] Timer tick, asking Buildbucket for the build status
[02:18:24.961] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:24.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:186:0) after 1m0s
[02:19:25.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:186:0)
[02:19:25.004] Timer tick, asking Buildbucket for the build status
[02:19:25.174] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:25.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:187:0) after 1m0s
[02:20:25.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:187:0)
[02:20:25.212] Timer tick, asking Buildbucket for the build status
[02:20:25.343] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:25.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:188:0) after 1m0s
[02:21:25.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:188:0)
[02:21:25.353] Timer tick, asking Buildbucket for the build status
[02:21:25.607] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:25.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:189:0) after 1m0s
[02:22:25.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:189:0)
[02:22:25.677] Timer tick, asking Buildbucket for the build status
[02:22:25.803] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:25.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:190:0) after 1m0s
[02:23:25.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:190:0)
[02:23:25.891] Timer tick, asking Buildbucket for the build status
[02:23:26.123] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:26.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:191:0) after 1m0s
[02:24:26.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:191:0)
[02:24:26.154] Timer tick, asking Buildbucket for the build status
[02:24:26.378] Build 8877022733004014048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:26.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9042452795079046224:192:0) after 1m0s
[02:25:25.832] Received PubSub notification, asking Buildbucket for the build status
[02:25:26.044] Build 8877022733004014048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:25:26.044] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1592619923926057",
    "created_by": "project:infra",
    "created_ts": "1592608435587057",
    "id": "8877022733004014048",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4177.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d01fd28f-268e-4184-90a1-0e8b87423c4f\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4177.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-udc6\"], \"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\": [\"5218-123b763\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1592608464273068",
    "status": "COMPLETED",
    "status_changed_ts": "1592619924983794",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9042452795079046224",
      "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/8877022733004014048/+/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:4ce7adb787d4bb10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1592619925221117",
    "url": "https://ci.chromium.org/b/8877022733004014048",
    "utcnow_ts": "1592619926021289"
  }
}
[02:25:26.044] Invocation finished in 3h11m31.818827261s with status SUCCEEDED