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

• parent_buildername:publish_tarball
• user_agent:recipe

[22:49:52.669] New invocation is queued and will start shortly
[22:49:52.669] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:49:54.422] Starting the invocation (attempt 1)
[22:49:54.469] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:49:54.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:49:54.469] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9049158482196177424",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"84.0.4106.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"601c75c5-bd3c-4c81-9d57-18d3326fa315\",\"title\":\"publish_tarball/0\"}]},\"version\":\"84.0.4106.2\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9049158482196177424",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[22:49:54.945] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1586213394557914",
    "id": "8883728419546827792",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4106.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"601c75c5-bd3c-4c81-9d57-18d3326fa315\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4106.2\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1586213394827082",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049158482196177424",
      "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/8883728419546827792/+/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": "1586213394827314",
    "url": "https://ci.chromium.org/b/8883728419546827792",
    "utcnow_ts": "1586213394934901"
  }
}
[22:49:54.945] Task URL: https://ci.chromium.org/b/8883728419546827792
[22:49:54.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:2:0) after 1m0s
[22:50:54.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:2:0)
[22:50:54.991] Timer tick, asking Buildbucket for the build status
[22:50:55.107] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:50:55.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:3:0) after 1m0s
[22:51:55.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:3:0)
[22:51:55.210] Timer tick, asking Buildbucket for the build status
[22:51:55.399] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:51:55.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:4:0) after 1m0s
[22:52:55.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:4:0)
[22:52:55.425] Timer tick, asking Buildbucket for the build status
[22:52:55.675] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:52:55.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:5:0) after 1m0s
[22:53:55.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:5:0)
[22:53:55.770] Timer tick, asking Buildbucket for the build status
[22:53:55.969] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:53:55.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:6:0) after 1m0s
[22:54:55.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:6:0)
[22:54:55.996] Timer tick, asking Buildbucket for the build status
[22:54:56.199] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:54:56.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:7:0) after 1m0s
[22:55:56.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:7:0)
[22:55:56.217] Timer tick, asking Buildbucket for the build status
[22:55:56.536] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:55:56.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:8:0) after 1m0s
[22:56:56.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:8:0)
[22:56:56.579] Timer tick, asking Buildbucket for the build status
[22:56:56.758] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:56:56.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:9:0) after 1m0s
[22:57:56.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:9:0)
[22:57:56.854] Timer tick, asking Buildbucket for the build status
[22:57:57.080] Build 8883728419546827792: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:57:57.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:10:0) after 1m0s
[22:58:24.603] Received PubSub notification, asking Buildbucket for the build status
[22:58:24.711] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:57.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:10:0)
[22:58:57.108] Timer tick, asking Buildbucket for the build status
[22:58:57.211] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:57.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:12:0) after 1m0s
[22:59:57.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:12:0)
[22:59:57.308] Timer tick, asking Buildbucket for the build status
[22:59:57.428] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:57.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:13:0) after 1m0s
[23:00:57.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:13:0)
[23:00:57.474] Timer tick, asking Buildbucket for the build status
[23:00:57.889] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:57.889] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:14:0) after 1m0s
[23:01:57.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:14:0)
[23:01:57.960] Timer tick, asking Buildbucket for the build status
[23:01:58.179] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:58.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:15:0) after 1m0s
[23:02:58.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:15:0)
[23:02:58.415] Timer tick, asking Buildbucket for the build status
[23:02:58.846] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:58.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:16:0) after 1m0s
[23:03:59.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:16:0)
[23:03:59.033] Timer tick, asking Buildbucket for the build status
[23:03:59.233] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:59.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:17:0) after 1m0s
[23:04:59.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:17:0)
[23:04:59.236] Timer tick, asking Buildbucket for the build status
[23:04:59.635] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:59.635] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:18:0) after 1m0s
[23:05:59.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:18:0)
[23:05:59.662] Timer tick, asking Buildbucket for the build status
[23:05:59.979] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:59.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:19:0) after 1m0s
[23:07:00.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:19:0)
[23:07:00.009] Timer tick, asking Buildbucket for the build status
[23:07:00.262] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:00.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:20:0) after 1m0s
[23:08:00.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:20:0)
[23:08:00.309] Timer tick, asking Buildbucket for the build status
[23:08:00.512] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:00.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:21:0) after 1m0s
[23:09:00.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:21:0)
[23:09:00.561] Timer tick, asking Buildbucket for the build status
[23:09:00.843] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:00.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:22:0) after 1m0s
[23:10:00.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:22:0)
[23:10:00.865] Timer tick, asking Buildbucket for the build status
[23:10:01.103] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:01.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:23:0) after 1m0s
[23:11:01.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:23:0)
[23:11:01.203] Timer tick, asking Buildbucket for the build status
[23:11:01.382] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:01.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:24:0) after 1m0s
[23:12:01.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:24:0)
[23:12:01.438] Timer tick, asking Buildbucket for the build status
[23:12:01.682] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:01.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:25:0) after 1m0s
[23:13:01.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:25:0)
[23:13:01.665] Timer tick, asking Buildbucket for the build status
[23:13:01.864] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:01.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:26:0) after 1m0s
[23:14:01.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:26:0)
[23:14:01.917] Timer tick, asking Buildbucket for the build status
[23:14:02.585] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:02.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:27:0) after 1m0s
[23:15:02.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:27:0)
[23:15:02.617] Timer tick, asking Buildbucket for the build status
[23:15:02.739] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:02.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:28:0) after 1m0s
[23:16:02.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:28:0)
[23:16:02.806] Timer tick, asking Buildbucket for the build status
[23:16:03.026] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:03.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:29:0) after 1m0s
[23:17:03.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:29:0)
[23:17:03.055] Timer tick, asking Buildbucket for the build status
[23:17:03.202] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:03.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:30:0) after 1m0s
[23:18:03.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:30:0)
[23:18:03.272] Timer tick, asking Buildbucket for the build status
[23:18:03.444] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:03.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:31:0) after 1m0s
[23:19:03.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:31:0)
[23:19:03.577] Timer tick, asking Buildbucket for the build status
[23:19:03.683] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:03.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:32:0) after 1m0s
[23:20:03.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:32:0)
[23:20:03.827] Timer tick, asking Buildbucket for the build status
[23:20:03.976] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:03.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:33:0) after 1m0s
[23:21:04.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:33:0)
[23:21:04.063] Timer tick, asking Buildbucket for the build status
[23:21:04.354] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:04.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:34:0) after 1m0s
[23:22:04.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:34:0)
[23:22:04.424] Timer tick, asking Buildbucket for the build status
[23:22:04.544] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:04.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:35:0) after 1m0s
[23:23:04.657] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:35:0)
[23:23:04.657] Timer tick, asking Buildbucket for the build status
[23:23:04.765] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:04.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:36:0) after 1m0s
[23:24:04.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:36:0)
[23:24:04.847] Timer tick, asking Buildbucket for the build status
[23:24:05.349] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:05.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:37:0) after 1m0s
[23:25:05.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:37:0)
[23:25:05.340] Timer tick, asking Buildbucket for the build status
[23:25:05.543] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:05.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:38:0) after 1m0s
[23:26:05.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:38:0)
[23:26:05.597] Timer tick, asking Buildbucket for the build status
[23:26:05.716] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:05.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:39:0) after 1m0s
[23:27:05.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:39:0)
[23:27:05.980] Timer tick, asking Buildbucket for the build status
[23:27:06.221] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:06.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:40:0) after 1m0s
[23:28:06.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:40:0)
[23:28:06.296] Timer tick, asking Buildbucket for the build status
[23:28:06.517] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:06.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:41:0) after 1m0s
[23:29:06.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:41:0)
[23:29:06.614] Timer tick, asking Buildbucket for the build status
[23:29:06.745] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:06.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:42:0) after 1m0s
[23:30:06.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:42:0)
[23:30:06.877] Timer tick, asking Buildbucket for the build status
[23:30:07.007] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:07.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:43:0) after 1m0s
[23:31:07.412] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:43:0)
[23:31:07.412] Timer tick, asking Buildbucket for the build status
[23:31:07.781] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:07.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:44:0) after 1m0s
[23:32:07.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:44:0)
[23:32:07.986] Timer tick, asking Buildbucket for the build status
[23:32:08.120] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:08.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:45:0) after 1m0s
[23:33:08.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:45:0)
[23:33:08.198] Timer tick, asking Buildbucket for the build status
[23:33:09.041] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:09.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:46:0) after 1m0s
[23:34:09.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:46:0)
[23:34:09.159] Timer tick, asking Buildbucket for the build status
[23:34:09.310] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:47:0) after 1m0s
[23:35:09.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:47:0)
[23:35:09.346] Timer tick, asking Buildbucket for the build status
[23:35:09.585] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:09.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:48:0) after 1m0s
[23:36:09.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:48:0)
[23:36:09.672] Timer tick, asking Buildbucket for the build status
[23:36:09.786] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:09.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:49:0) after 1m0s
[23:37:09.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:49:0)
[23:37:09.785] Timer tick, asking Buildbucket for the build status
[23:37:09.942] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:09.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:50:0) after 1m0s
[23:38:10.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:50:0)
[23:38:10.058] Timer tick, asking Buildbucket for the build status
[23:38:10.361] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:10.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:51:0) after 1m0s
[23:39:10.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:51:0)
[23:39:10.623] Timer tick, asking Buildbucket for the build status
[23:39:10.858] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:10.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:52:0) after 1m0s
[23:40:10.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:52:0)
[23:40:10.958] Timer tick, asking Buildbucket for the build status
[23:40:11.581] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:11.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:53:0) after 1m0s
[23:41:11.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:53:0)
[23:41:11.754] Timer tick, asking Buildbucket for the build status
[23:41:11.981] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:11.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:54:0) after 1m0s
[23:42:12.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:54:0)
[23:42:12.093] Timer tick, asking Buildbucket for the build status
[23:42:12.482] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:12.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:55:0) after 1m0s
[23:43:12.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:55:0)
[23:43:12.561] Timer tick, asking Buildbucket for the build status
[23:43:12.701] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:12.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:56:0) after 1m0s
[23:44:12.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:56:0)
[23:44:12.825] Timer tick, asking Buildbucket for the build status
[23:44:12.959] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:12.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:57:0) after 1m0s
[23:45:13.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:57:0)
[23:45:13.075] Timer tick, asking Buildbucket for the build status
[23:45:13.295] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:13.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:58:0) after 1m0s
[23:46:13.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:58:0)
[23:46:13.377] Timer tick, asking Buildbucket for the build status
[23:46:13.558] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:13.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:59:0) after 1m0s
[23:47:13.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:59:0)
[23:47:13.688] Timer tick, asking Buildbucket for the build status
[23:47:14.198] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:14.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:60:0) after 1m0s
[23:48:14.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:60:0)
[23:48:14.283] Timer tick, asking Buildbucket for the build status
[23:48:14.441] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:14.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:61:0) after 1m0s
[23:49:14.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:61:0)
[23:49:14.454] Timer tick, asking Buildbucket for the build status
[23:49:14.615] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:14.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:62:0) after 1m0s
[23:50:14.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:62:0)
[23:50:14.722] Timer tick, asking Buildbucket for the build status
[23:50:15.048] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:15.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:63:0) after 1m0s
[23:51:15.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:63:0)
[23:51:15.106] Timer tick, asking Buildbucket for the build status
[23:51:15.238] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:15.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:64:0) after 1m0s
[23:52:15.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:64:0)
[23:52:15.273] Timer tick, asking Buildbucket for the build status
[23:52:15.438] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:15.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:65:0) after 1m0s
[23:53:15.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:65:0)
[23:53:15.499] Timer tick, asking Buildbucket for the build status
[23:53:15.955] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:15.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:66:0) after 1m0s
[23:54:15.980] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:66:0)
[23:54:15.980] Timer tick, asking Buildbucket for the build status
[23:54:16.251] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:16.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:67:0) after 1m0s
[23:55:16.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:67:0)
[23:55:16.277] Timer tick, asking Buildbucket for the build status
[23:55:16.513] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:16.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:68:0) after 1m0s
[23:56:16.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:68:0)
[23:56:16.556] Timer tick, asking Buildbucket for the build status
[23:56:16.735] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:16.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:69:0) after 1m0s
[23:57:16.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:69:0)
[23:57:16.797] Timer tick, asking Buildbucket for the build status
[23:57:16.910] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:16.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:70:0) after 1m0s
[23:58:16.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:70:0)
[23:58:16.956] Timer tick, asking Buildbucket for the build status
[23:58:17.104] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:17.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:71:0) after 1m0s
[23:59:17.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:71:0)
[23:59:17.128] Timer tick, asking Buildbucket for the build status
[23:59:18.623] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:18.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:72:0) after 1m0s
[00:00:18.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:72:0)
[00:00:18.713] Timer tick, asking Buildbucket for the build status
[00:00:18.850] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:18.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:73:0) after 1m0s
[00:01:18.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:73:0)
[00:01:18.935] Timer tick, asking Buildbucket for the build status
[00:01:19.076] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:19.076] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:74:0) after 1m0s
[00:02:19.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:74:0)
[00:02:19.187] Timer tick, asking Buildbucket for the build status
[00:02:19.382] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:19.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:75:0) after 1m0s
[00:03:19.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:75:0)
[00:03:19.409] Timer tick, asking Buildbucket for the build status
[00:03:19.546] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:19.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:76:0) after 1m0s
[00:04:19.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:76:0)
[00:04:19.634] Timer tick, asking Buildbucket for the build status
[00:04:19.995] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:19.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:77:0) after 1m0s
[00:05:20.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:77:0)
[00:05:20.032] Timer tick, asking Buildbucket for the build status
[00:05:20.470] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:20.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:78:0) after 1m0s
[00:06:20.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:78:0)
[00:06:20.571] Timer tick, asking Buildbucket for the build status
[00:06:20.848] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:20.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:79:0) after 1m0s
[00:07:20.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:79:0)
[00:07:20.859] Timer tick, asking Buildbucket for the build status
[00:07:21.071] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:21.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:80:0) after 1m0s
[00:08:21.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:80:0)
[00:08:21.148] Timer tick, asking Buildbucket for the build status
[00:08:21.373] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:21.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:81:0) after 1m0s
[00:09:21.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:81:0)
[00:09:21.430] Timer tick, asking Buildbucket for the build status
[00:09:21.630] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:21.630] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:82:0) after 1m0s
[00:10:21.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:82:0)
[00:10:21.703] Timer tick, asking Buildbucket for the build status
[00:10:22.154] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:22.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:83:0) after 1m0s
[00:11:22.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:83:0)
[00:11:22.208] Timer tick, asking Buildbucket for the build status
[00:11:22.414] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:22.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:84:0) after 1m0s
[00:12:22.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:84:0)
[00:12:22.437] Timer tick, asking Buildbucket for the build status
[00:12:22.577] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:22.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:85:0) after 1m0s
[00:13:22.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:85:0)
[00:13:22.708] Timer tick, asking Buildbucket for the build status
[00:13:22.908] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:22.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:86:0) after 1m0s
[00:14:23.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:86:0)
[00:14:23.022] Timer tick, asking Buildbucket for the build status
[00:14:23.221] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:23.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:87:0) after 1m0s
[00:15:23.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:87:0)
[00:15:23.379] Timer tick, asking Buildbucket for the build status
[00:15:23.778] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:23.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:88:0) after 1m0s
[00:16:23.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:88:0)
[00:16:23.910] Timer tick, asking Buildbucket for the build status
[00:16:24.444] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:24.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:89:0) after 1m0s
[00:17:24.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:89:0)
[00:17:24.551] Timer tick, asking Buildbucket for the build status
[00:17:24.673] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:24.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:90:0) after 1m0s
[00:18:24.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:90:0)
[00:18:24.803] Timer tick, asking Buildbucket for the build status
[00:18:25.073] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:25.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:91:0) after 1m0s
[00:19:25.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:91:0)
[00:19:25.106] Timer tick, asking Buildbucket for the build status
[00:19:25.335] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:25.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:92:0) after 1m0s
[00:20:25.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:92:0)
[00:20:25.517] Timer tick, asking Buildbucket for the build status
[00:20:25.845] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:25.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:93:0) after 1m0s
[00:21:25.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:93:0)
[00:21:25.919] Timer tick, asking Buildbucket for the build status
[00:21:26.085] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:26.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:94:0) after 1m0s
[00:22:26.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:94:0)
[00:22:26.127] Timer tick, asking Buildbucket for the build status
[00:22:26.514] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:26.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:95:0) after 1m0s
[00:23:26.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:95:0)
[00:23:26.525] Timer tick, asking Buildbucket for the build status
[00:23:26.904] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:26.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:96:0) after 1m0s
[00:24:26.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:96:0)
[00:24:26.917] Timer tick, asking Buildbucket for the build status
[00:24:27.247] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:27.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:97:0) after 1m0s
[00:25:27.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:97:0)
[00:25:27.312] Timer tick, asking Buildbucket for the build status
[00:25:27.494] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:27.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:98:0) after 1m0s
[00:26:27.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:98:0)
[00:26:27.574] Timer tick, asking Buildbucket for the build status
[00:26:28.248] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:28.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:99:0) after 1m0s
[00:27:28.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:99:0)
[00:27:28.290] Timer tick, asking Buildbucket for the build status
[00:27:28.793] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:28.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:100:0) after 1m0s
[00:28:28.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:100:0)
[00:28:28.791] Timer tick, asking Buildbucket for the build status
[00:28:29.250] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:29.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:101:0) after 1m0s
[00:29:29.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:101:0)
[00:29:29.350] Timer tick, asking Buildbucket for the build status
[00:29:29.480] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:29.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:102:0) after 1m0s
[00:30:29.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:102:0)
[00:30:29.553] Timer tick, asking Buildbucket for the build status
[00:30:29.708] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:29.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:103:0) after 1m0s
[00:31:29.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:103:0)
[00:31:29.770] Timer tick, asking Buildbucket for the build status
[00:31:29.923] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:29.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:104:0) after 1m0s
[00:32:30.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:104:0)
[00:32:30.219] Timer tick, asking Buildbucket for the build status
[00:32:30.393] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:30.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:105:0) after 1m0s
[00:33:30.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:105:0)
[00:33:30.610] Timer tick, asking Buildbucket for the build status
[00:33:30.735] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:30.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:106:0) after 1m0s
[00:34:30.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:106:0)
[00:34:30.907] Timer tick, asking Buildbucket for the build status
[00:34:31.085] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:31.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:107:0) after 1m0s
[00:35:31.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:107:0)
[00:35:31.272] Timer tick, asking Buildbucket for the build status
[00:35:31.763] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:108:0) after 1m0s
[00:36:31.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:108:0)
[00:36:31.864] Timer tick, asking Buildbucket for the build status
[00:36:31.995] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:31.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:109:0) after 1m0s
[00:37:32.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:109:0)
[00:37:32.201] Timer tick, asking Buildbucket for the build status
[00:37:32.329] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:32.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:110:0) after 1m0s
[00:38:32.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:110:0)
[00:38:32.408] Timer tick, asking Buildbucket for the build status
[00:38:32.601] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:32.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:111:0) after 1m0s
[00:39:32.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:111:0)
[00:39:32.717] Timer tick, asking Buildbucket for the build status
[00:39:34.927] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:34.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:112:0) after 1m0s
[00:40:34.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:112:0)
[00:40:34.986] Timer tick, asking Buildbucket for the build status
[00:40:35.282] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:35.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:113:0) after 1m0s
[00:41:35.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:113:0)
[00:41:35.368] Timer tick, asking Buildbucket for the build status
[00:41:35.572] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:35.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:114:0) after 1m0s
[00:42:35.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:114:0)
[00:42:35.614] Timer tick, asking Buildbucket for the build status
[00:42:35.748] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:35.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:115:0) after 1m0s
[00:43:35.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:115:0)
[00:43:35.959] Timer tick, asking Buildbucket for the build status
[00:43:36.114] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:36.114] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:116:0) after 1m0s
[00:44:36.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:116:0)
[00:44:36.205] Timer tick, asking Buildbucket for the build status
[00:44:36.567] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:36.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:117:0) after 1m0s
[00:45:36.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:117:0)
[00:45:36.662] Timer tick, asking Buildbucket for the build status
[00:45:36.821] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:36.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:118:0) after 1m0s
[00:46:36.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:118:0)
[00:46:36.941] Timer tick, asking Buildbucket for the build status
[00:46:37.058] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:37.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:119:0) after 1m0s
[00:47:37.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:119:0)
[00:47:37.100] Timer tick, asking Buildbucket for the build status
[00:47:37.248] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:37.248] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:120:0) after 1m0s
[00:48:37.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:120:0)
[00:48:37.323] Timer tick, asking Buildbucket for the build status
[00:48:37.437] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:37.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:121:0) after 1m0s
[00:49:37.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:121:0)
[00:49:37.473] Timer tick, asking Buildbucket for the build status
[00:49:37.777] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:37.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:122:0) after 1m0s
[00:50:37.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:122:0)
[00:50:37.806] Timer tick, asking Buildbucket for the build status
[00:50:38.124] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:38.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:123:0) after 1m0s
[00:51:38.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:123:0)
[00:51:38.201] Timer tick, asking Buildbucket for the build status
[00:51:38.355] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:38.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:124:0) after 1m0s
[00:52:38.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:124:0)
[00:52:38.422] Timer tick, asking Buildbucket for the build status
[00:52:38.616] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:38.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:125:0) after 1m0s
[00:53:38.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:125:0)
[00:53:38.760] Timer tick, asking Buildbucket for the build status
[00:53:38.903] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:38.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:126:0) after 1m0s
[00:54:39.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:126:0)
[00:54:39.053] Timer tick, asking Buildbucket for the build status
[00:54:39.286] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:39.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:127:0) after 1m0s
[00:55:39.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:127:0)
[00:55:39.287] Timer tick, asking Buildbucket for the build status
[00:55:39.519] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:39.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:128:0) after 1m0s
[00:56:39.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:128:0)
[00:56:39.516] Timer tick, asking Buildbucket for the build status
[00:56:40.019] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:40.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:129:0) after 1m0s
[00:57:40.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:129:0)
[00:57:40.087] Timer tick, asking Buildbucket for the build status
[00:57:40.374] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:40.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:130:0) after 1m0s
[00:58:40.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:130:0)
[00:58:40.465] Timer tick, asking Buildbucket for the build status
[00:58:40.636] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:40.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:131:0) after 1m0s
[00:59:40.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:131:0)
[00:59:40.620] Timer tick, asking Buildbucket for the build status
[00:59:40.895] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:40.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:132:0) after 1m0s
[01:00:41.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:132:0)
[01:00:41.045] Timer tick, asking Buildbucket for the build status
[01:00:41.211] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:41.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:133:0) after 1m0s
[01:01:41.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:133:0)
[01:01:41.245] Timer tick, asking Buildbucket for the build status
[01:01:41.455] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:41.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:134:0) after 1m0s
[01:02:41.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:134:0)
[01:02:41.639] Timer tick, asking Buildbucket for the build status
[01:02:41.779] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:41.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:135:0) after 1m0s
[01:03:41.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:135:0)
[01:03:41.804] Timer tick, asking Buildbucket for the build status
[01:03:41.929] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:41.929] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:136:0) after 1m0s
[01:04:42.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:136:0)
[01:04:42.088] Timer tick, asking Buildbucket for the build status
[01:04:42.732] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:42.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:137:0) after 1m0s
[01:05:42.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:137:0)
[01:05:42.843] Timer tick, asking Buildbucket for the build status
[01:05:42.988] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:42.988] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:138:0) after 1m0s
[01:06:43.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:138:0)
[01:06:43.035] Timer tick, asking Buildbucket for the build status
[01:06:43.259] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:43.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:139:0) after 1m0s
[01:07:43.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:139:0)
[01:07:43.331] Timer tick, asking Buildbucket for the build status
[01:07:43.646] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:43.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:140:0) after 1m0s
[01:08:43.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:140:0)
[01:08:43.696] Timer tick, asking Buildbucket for the build status
[01:08:43.827] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:43.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:141:0) after 1m0s
[01:09:43.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:141:0)
[01:09:43.934] Timer tick, asking Buildbucket for the build status
[01:09:44.391] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:44.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:142:0) after 1m0s
[01:10:44.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:142:0)
[01:10:44.530] Timer tick, asking Buildbucket for the build status
[01:10:44.837] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:44.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:143:0) after 1m0s
[01:11:45.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:143:0)
[01:11:45.176] Timer tick, asking Buildbucket for the build status
[01:11:46.446] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:46.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:144:0) after 1m0s
[01:12:46.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:144:0)
[01:12:46.463] Timer tick, asking Buildbucket for the build status
[01:12:46.629] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:46.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:145:0) after 1m0s
[01:13:46.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:145:0)
[01:13:46.731] Timer tick, asking Buildbucket for the build status
[01:13:46.868] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:46.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:146:0) after 1m0s
[01:14:46.931] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:146:0)
[01:14:46.931] Timer tick, asking Buildbucket for the build status
[01:14:47.266] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:47.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:147:0) after 1m0s
[01:15:47.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:147:0)
[01:15:47.447] Timer tick, asking Buildbucket for the build status
[01:15:47.913] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:47.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:148:0) after 1m0s
[01:16:48.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:148:0)
[01:16:48.207] Timer tick, asking Buildbucket for the build status
[01:16:48.602] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:48.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:149:0) after 1m0s
[01:17:48.788] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:149:0)
[01:17:48.788] Timer tick, asking Buildbucket for the build status
[01:17:48.977] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:48.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:150:0) after 1m0s
[01:18:48.954] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:150:0)
[01:18:48.954] Timer tick, asking Buildbucket for the build status
[01:18:49.096] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:49.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:151:0) after 1m0s
[01:19:49.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:151:0)
[01:19:49.141] Timer tick, asking Buildbucket for the build status
[01:19:49.358] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:49.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:152:0) after 1m0s
[01:20:49.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:152:0)
[01:20:49.460] Timer tick, asking Buildbucket for the build status
[01:20:49.647] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:49.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:153:0) after 1m0s
[01:21:49.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:153:0)
[01:21:49.690] Timer tick, asking Buildbucket for the build status
[01:21:49.984] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:49.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:154:0) after 1m0s
[01:22:50.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:154:0)
[01:22:50.126] Timer tick, asking Buildbucket for the build status
[01:22:50.333] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:50.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:155:0) after 1m0s
[01:23:50.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:155:0)
[01:23:50.457] Timer tick, asking Buildbucket for the build status
[01:23:50.694] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:50.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:156:0) after 1m0s
[01:24:50.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:156:0)
[01:24:50.790] Timer tick, asking Buildbucket for the build status
[01:24:50.981] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:50.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:157:0) after 1m0s
[01:25:51.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:157:0)
[01:25:51.041] Timer tick, asking Buildbucket for the build status
[01:25:51.170] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:51.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:158:0) after 1m0s
[01:26:51.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:158:0)
[01:26:51.251] Timer tick, asking Buildbucket for the build status
[01:26:51.425] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:51.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:159:0) after 1m0s
[01:27:51.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:159:0)
[01:27:51.538] Timer tick, asking Buildbucket for the build status
[01:27:51.727] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:51.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:160:0) after 1m0s
[01:28:51.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:160:0)
[01:28:51.844] Timer tick, asking Buildbucket for the build status
[01:28:52.008] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:52.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:161:0) after 1m0s
[01:29:52.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:161:0)
[01:29:52.163] Timer tick, asking Buildbucket for the build status
[01:29:52.314] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:52.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:162:0) after 1m0s
[01:30:52.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:162:0)
[01:30:52.487] Timer tick, asking Buildbucket for the build status
[01:30:52.784] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:52.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:163:0) after 1m0s
[01:31:52.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:163:0)
[01:31:52.822] Timer tick, asking Buildbucket for the build status
[01:31:53.098] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:53.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:164:0) after 1m0s
[01:32:53.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:164:0)
[01:32:53.125] Timer tick, asking Buildbucket for the build status
[01:32:53.466] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:53.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:165:0) after 1m0s
[01:33:53.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:165:0)
[01:33:53.530] Timer tick, asking Buildbucket for the build status
[01:33:53.775] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:53.775] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:166:0) after 1m0s
[01:34:53.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:166:0)
[01:34:53.800] Timer tick, asking Buildbucket for the build status
[01:34:54.201] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:54.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:167:0) after 1m0s
[01:35:54.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:167:0)
[01:35:54.277] Timer tick, asking Buildbucket for the build status
[01:35:54.477] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:54.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:168:0) after 1m0s
[01:36:54.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:168:0)
[01:36:54.568] Timer tick, asking Buildbucket for the build status
[01:36:54.849] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:54.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:169:0) after 1m0s
[01:37:54.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:169:0)
[01:37:54.986] Timer tick, asking Buildbucket for the build status
[01:37:55.397] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:55.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:170:0) after 1m0s
[01:38:55.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:170:0)
[01:38:55.475] Timer tick, asking Buildbucket for the build status
[01:38:55.779] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:55.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:171:0) after 1m0s
[01:39:55.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:171:0)
[01:39:55.815] Timer tick, asking Buildbucket for the build status
[01:39:56.002] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:56.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:172:0) after 1m0s
[01:40:56.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:172:0)
[01:40:56.110] Timer tick, asking Buildbucket for the build status
[01:40:56.464] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:56.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:173:0) after 1m0s
[01:41:56.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:173:0)
[01:41:56.527] Timer tick, asking Buildbucket for the build status
[01:41:56.680] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:56.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:174:0) after 1m0s
[01:42:56.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:174:0)
[01:42:56.696] Timer tick, asking Buildbucket for the build status
[01:42:56.871] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:56.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:175:0) after 1m0s
[01:43:56.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:175:0)
[01:43:56.978] Timer tick, asking Buildbucket for the build status
[01:43:57.126] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:57.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:176:0) after 1m0s
[01:44:57.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:176:0)
[01:44:57.192] Timer tick, asking Buildbucket for the build status
[01:44:57.369] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:57.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:177:0) after 1m0s
[01:45:57.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:177:0)
[01:45:57.398] Timer tick, asking Buildbucket for the build status
[01:45:57.678] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:57.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:178:0) after 1m0s
[01:46:57.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:178:0)
[01:46:57.793] Timer tick, asking Buildbucket for the build status
[01:46:58.177] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:58.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:179:0) after 1m0s
[01:47:58.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:179:0)
[01:47:58.302] Timer tick, asking Buildbucket for the build status
[01:47:58.437] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:58.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:180:0) after 1m0s
[01:48:58.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:180:0)
[01:48:58.481] Timer tick, asking Buildbucket for the build status
[01:48:58.855] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:58.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:181:0) after 1m0s
[01:49:58.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:181:0)
[01:49:58.870] Timer tick, asking Buildbucket for the build status
[01:49:59.072] Build 8883728419546827792: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:59.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049158482196177424:182:0) after 1m0s
[01:50:01.448] Received PubSub notification, asking Buildbucket for the build status
[01:50:01.673] Build 8883728419546827792: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:50:01.673] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1586224200496615",
    "created_by": "project:infra",
    "created_ts": "1586213394557914",
    "id": "8883728419546827792",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4106.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"601c75c5-bd3c-4c81-9d57-18d3326fa315\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"84.0.4106.2\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"84.0.4106.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"601c75c5-bd3c-4c81-9d57-18d3326fa315\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-0s1l\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"84.0.4106.2\"}, \"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-0s1l\"], \"image\": [\"chrome-xenial-20040500-42c1ff87780\"], \"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\": [\"4926-84b94b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1586213903577159",
    "status": "COMPLETED",
    "status_changed_ts": "1586224201055734",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9049158482196177424",
      "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/8883728419546827792/+/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:4b6a812416a75a10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1586224201072172",
    "url": "https://ci.chromium.org/b/8883728419546827792",
    "utcnow_ts": "1586224201656912"
  }
}
[01:50:01.673] Invocation finished in 3h0m9.025951039s with status SUCCEEDED