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

• parent_buildername:publish_tarball
• user_agent:recipe

[07:39:20.200] New invocation is queued and will start shortly
[07:39:20.200] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:39:21.321] Starting the invocation (attempt 1)
[07:39:21.357] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:39:21.357] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:39:21.358] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9040790250614146944",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4196.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"481279a7-6b66-401c-b1b4-a0483b018a9e\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4196.0\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9040790250614146944",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[07:39:22.097] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1594193961507978",
    "id": "8875360188577047056",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4196.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"481279a7-6b66-401c-b1b4-a0483b018a9e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4196.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1594193961850081",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040790250614146944",
      "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/8875360188577047056/+/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": "1594193961850270",
    "url": "https://ci.chromium.org/b/8875360188577047056",
    "utcnow_ts": "1594193962086106"
  }
}
[07:39:22.097] Task URL: https://ci.chromium.org/b/8875360188577047056
[07:39:22.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:2:0) after 1m0s
[07:39:51.522] Received PubSub notification, asking Buildbucket for the build status
[07:39:51.653] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:22.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:2:0)
[07:40:22.093] Timer tick, asking Buildbucket for the build status
[07:40:22.687] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:22.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:4:0) after 1m0s
[07:41:22.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:4:0)
[07:41:22.740] Timer tick, asking Buildbucket for the build status
[07:41:22.960] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:22.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:5:0) after 1m0s
[07:42:22.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:5:0)
[07:42:22.945] Timer tick, asking Buildbucket for the build status
[07:42:23.232] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:23.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:6:0) after 1m0s
[07:43:23.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:6:0)
[07:43:23.219] Timer tick, asking Buildbucket for the build status
[07:43:23.575] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:23.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:7:0) after 1m0s
[07:44:23.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:7:0)
[07:44:23.621] Timer tick, asking Buildbucket for the build status
[07:44:23.830] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:23.830] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:8:0) after 1m0s
[07:45:23.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:8:0)
[07:45:23.880] Timer tick, asking Buildbucket for the build status
[07:45:24.041] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:24.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:9:0) after 1m0s
[07:46:24.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:9:0)
[07:46:24.043] Timer tick, asking Buildbucket for the build status
[07:46:24.178] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:24.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:10:0) after 1m0s
[07:47:24.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:10:0)
[07:47:24.257] Timer tick, asking Buildbucket for the build status
[07:47:24.442] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:24.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:11:0) after 1m0s
[07:48:24.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:11:0)
[07:48:24.843] Timer tick, asking Buildbucket for the build status
[07:48:25.243] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:25.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:12:0) after 1m0s
[07:49:25.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:12:0)
[07:49:25.796] Timer tick, asking Buildbucket for the build status
[07:49:26.224] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:26.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:13:0) after 1m0s
[07:50:26.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:13:0)
[07:50:26.275] Timer tick, asking Buildbucket for the build status
[07:50:26.481] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:26.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:14:0) after 1m0s
[07:51:26.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:14:0)
[07:51:26.540] Timer tick, asking Buildbucket for the build status
[07:51:26.972] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:26.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:15:0) after 1m0s
[07:52:27.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:15:0)
[07:52:27.016] Timer tick, asking Buildbucket for the build status
[07:52:27.567] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:27.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:16:0) after 1m0s
[07:53:27.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:16:0)
[07:53:27.982] Timer tick, asking Buildbucket for the build status
[07:53:28.071] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:28.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:17:0) after 1m0s
[07:54:28.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:17:0)
[07:54:28.291] Timer tick, asking Buildbucket for the build status
[07:54:29.436] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:29.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:18:0) after 1m0s
[07:55:29.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:18:0)
[07:55:29.531] Timer tick, asking Buildbucket for the build status
[07:55:29.735] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:29.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:19:0) after 1m0s
[07:56:29.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:19:0)
[07:56:29.821] Timer tick, asking Buildbucket for the build status
[07:56:29.965] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:29.965] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:20:0) after 1m0s
[07:57:30.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:20:0)
[07:57:30.113] Timer tick, asking Buildbucket for the build status
[07:57:30.289] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:30.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:21:0) after 1m0s
[07:58:30.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:21:0)
[07:58:30.342] Timer tick, asking Buildbucket for the build status
[07:58:30.818] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:30.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:22:0) after 1m0s
[07:59:30.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:22:0)
[07:59:30.964] Timer tick, asking Buildbucket for the build status
[07:59:31.154] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:31.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:23:0) after 1m0s
[08:00:31.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:23:0)
[08:00:31.458] Timer tick, asking Buildbucket for the build status
[08:00:31.689] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:31.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:24:0) after 1m0s
[08:01:31.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:24:0)
[08:01:31.992] Timer tick, asking Buildbucket for the build status
[08:01:32.121] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:32.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:25:0) after 1m0s
[08:02:32.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:25:0)
[08:02:32.227] Timer tick, asking Buildbucket for the build status
[08:02:32.424] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:32.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:26:0) after 1m0s
[08:03:32.445] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:26:0)
[08:03:32.445] Timer tick, asking Buildbucket for the build status
[08:03:32.572] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:32.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:27:0) after 1m0s
[08:04:32.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:27:0)
[08:04:32.670] Timer tick, asking Buildbucket for the build status
[08:04:32.795] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:32.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:28:0) after 1m0s
[08:05:32.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:28:0)
[08:05:32.945] Timer tick, asking Buildbucket for the build status
[08:05:33.145] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:33.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:29:0) after 1m0s
[08:06:33.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:29:0)
[08:06:33.278] Timer tick, asking Buildbucket for the build status
[08:06:33.499] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:33.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:30:0) after 1m0s
[08:07:33.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:30:0)
[08:07:33.711] Timer tick, asking Buildbucket for the build status
[08:07:34.654] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:34.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:31:0) after 1m0s
[08:08:34.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:31:0)
[08:08:34.666] Timer tick, asking Buildbucket for the build status
[08:08:34.812] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:34.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:32:0) after 1m0s
[08:09:34.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:32:0)
[08:09:34.937] Timer tick, asking Buildbucket for the build status
[08:09:35.131] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:35.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:33:0) after 1m0s
[08:10:35.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:33:0)
[08:10:35.154] Timer tick, asking Buildbucket for the build status
[08:10:35.261] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:35.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:34:0) after 1m0s
[08:11:35.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:34:0)
[08:11:35.268] Timer tick, asking Buildbucket for the build status
[08:11:35.379] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:35.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:35:0) after 1m0s
[08:12:35.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:35:0)
[08:12:35.428] Timer tick, asking Buildbucket for the build status
[08:12:35.769] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:35.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:36:0) after 1m0s
[08:13:35.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:36:0)
[08:13:35.761] Timer tick, asking Buildbucket for the build status
[08:13:36.014] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:36.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:37:0) after 1m0s
[08:14:36.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:37:0)
[08:14:36.036] Timer tick, asking Buildbucket for the build status
[08:14:36.170] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:36.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:38:0) after 1m0s
[08:15:36.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:38:0)
[08:15:36.148] Timer tick, asking Buildbucket for the build status
[08:15:36.507] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:36.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:39:0) after 1m0s
[08:16:36.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:39:0)
[08:16:36.542] Timer tick, asking Buildbucket for the build status
[08:16:36.870] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:36.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:40:0) after 1m0s
[08:17:36.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:40:0)
[08:17:36.946] Timer tick, asking Buildbucket for the build status
[08:17:37.116] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:37.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:41:0) after 1m0s
[08:18:37.140] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:41:0)
[08:18:37.140] Timer tick, asking Buildbucket for the build status
[08:18:37.572] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:37.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:42:0) after 1m0s
[08:19:37.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:42:0)
[08:19:37.598] Timer tick, asking Buildbucket for the build status
[08:19:37.901] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:37.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:43:0) after 1m0s
[08:20:37.950] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:43:0)
[08:20:37.950] Timer tick, asking Buildbucket for the build status
[08:20:38.893] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:38.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:44:0) after 1m0s
[08:21:38.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:44:0)
[08:21:38.897] Timer tick, asking Buildbucket for the build status
[08:21:39.012] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:39.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:45:0) after 1m0s
[08:22:39.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:45:0)
[08:22:39.045] Timer tick, asking Buildbucket for the build status
[08:22:39.242] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:39.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:46:0) after 1m0s
[08:23:39.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:46:0)
[08:23:39.294] Timer tick, asking Buildbucket for the build status
[08:23:39.444] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:39.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:47:0) after 1m0s
[08:24:39.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:47:0)
[08:24:39.490] Timer tick, asking Buildbucket for the build status
[08:24:39.801] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:39.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:48:0) after 1m0s
[08:25:39.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:48:0)
[08:25:39.844] Timer tick, asking Buildbucket for the build status
[08:25:41.826] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:41.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:49:0) after 1m0s
[08:26:41.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:49:0)
[08:26:41.847] Timer tick, asking Buildbucket for the build status
[08:26:42.900] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:42.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:50:0) after 1m0s
[08:27:42.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:50:0)
[08:27:42.957] Timer tick, asking Buildbucket for the build status
[08:27:43.165] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:43.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:51:0) after 1m0s
[08:28:43.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:51:0)
[08:28:43.248] Timer tick, asking Buildbucket for the build status
[08:28:43.495] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:43.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:52:0) after 1m0s
[08:29:43.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:52:0)
[08:29:43.627] Timer tick, asking Buildbucket for the build status
[08:29:43.857] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:43.857] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:53:0) after 1m0s
[08:30:43.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:53:0)
[08:30:43.921] Timer tick, asking Buildbucket for the build status
[08:30:44.280] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:44.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:54:0) after 1m0s
[08:31:44.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:54:0)
[08:31:44.337] Timer tick, asking Buildbucket for the build status
[08:31:45.032] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:45.032] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:55:0) after 1m0s
[08:32:45.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:55:0)
[08:32:45.036] Timer tick, asking Buildbucket for the build status
[08:32:45.192] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:45.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:56:0) after 1m0s
[08:33:45.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:56:0)
[08:33:45.919] Timer tick, asking Buildbucket for the build status
[08:33:46.303] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:46.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:57:0) after 1m0s
[08:34:46.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:57:0)
[08:34:46.384] Timer tick, asking Buildbucket for the build status
[08:34:46.512] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:46.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:58:0) after 1m0s
[08:35:46.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:58:0)
[08:35:46.700] Timer tick, asking Buildbucket for the build status
[08:35:47.121] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:47.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:59:0) after 1m0s
[08:36:47.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:59:0)
[08:36:47.199] Timer tick, asking Buildbucket for the build status
[08:36:47.543] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:47.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:60:0) after 1m0s
[08:37:47.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:60:0)
[08:37:47.633] Timer tick, asking Buildbucket for the build status
[08:37:49.280] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:49.280] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:61:0) after 1m0s
[08:38:49.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:61:0)
[08:38:49.534] Timer tick, asking Buildbucket for the build status
[08:38:49.707] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:49.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:62:0) after 1m0s
[08:39:49.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:62:0)
[08:39:49.801] Timer tick, asking Buildbucket for the build status
[08:39:50.002] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:50.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:63:0) after 1m0s
[08:40:50.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:63:0)
[08:40:50.098] Timer tick, asking Buildbucket for the build status
[08:40:50.247] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:50.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:64:0) after 1m0s
[08:41:50.292] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:64:0)
[08:41:50.292] Timer tick, asking Buildbucket for the build status
[08:41:50.535] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:50.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:65:0) after 1m0s
[08:42:50.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:65:0)
[08:42:50.599] Timer tick, asking Buildbucket for the build status
[08:42:51.722] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:51.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:66:0) after 1m0s
[08:43:51.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:66:0)
[08:43:51.786] Timer tick, asking Buildbucket for the build status
[08:43:51.991] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:51.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:67:0) after 1m0s
[08:44:52.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:67:0)
[08:44:52.019] Timer tick, asking Buildbucket for the build status
[08:44:52.575] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:52.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:68:0) after 1m0s
[08:45:52.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:68:0)
[08:45:52.592] Timer tick, asking Buildbucket for the build status
[08:45:53.328] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:53.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:69:0) after 1m0s
[08:46:53.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:69:0)
[08:46:53.352] Timer tick, asking Buildbucket for the build status
[08:46:53.702] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:53.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:70:0) after 1m0s
[08:47:53.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:70:0)
[08:47:53.749] Timer tick, asking Buildbucket for the build status
[08:47:53.997] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:53.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:71:0) after 1m0s
[08:48:54.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:71:0)
[08:48:54.022] Timer tick, asking Buildbucket for the build status
[08:48:54.184] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:54.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:72:0) after 1m0s
[08:49:54.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:72:0)
[08:49:54.266] Timer tick, asking Buildbucket for the build status
[08:49:54.425] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:54.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:73:0) after 1m0s
[08:50:54.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:73:0)
[08:50:54.472] Timer tick, asking Buildbucket for the build status
[08:50:54.840] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:54.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:74:0) after 1m0s
[08:51:55.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:74:0)
[08:51:55.264] Timer tick, asking Buildbucket for the build status
[08:51:55.375] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:55.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:75:0) after 1m0s
[08:52:55.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:75:0)
[08:52:55.487] Timer tick, asking Buildbucket for the build status
[08:52:55.670] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:55.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:76:0) after 1m0s
[08:53:55.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:76:0)
[08:53:55.772] Timer tick, asking Buildbucket for the build status
[08:53:55.935] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:55.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:77:0) after 1m0s
[08:54:56.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:77:0)
[08:54:56.035] Timer tick, asking Buildbucket for the build status
[08:54:56.165] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:56.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:78:0) after 1m0s
[08:55:57.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:78:0)
[08:55:57.473] Timer tick, asking Buildbucket for the build status
[08:55:57.676] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:57.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:79:0) after 1m0s
[08:56:57.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:79:0)
[08:56:57.887] Timer tick, asking Buildbucket for the build status
[08:56:58.062] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:58.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:80:0) after 1m0s
[08:57:58.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:80:0)
[08:57:58.130] Timer tick, asking Buildbucket for the build status
[08:57:58.596] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:58.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:81:0) after 1m0s
[08:58:58.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:81:0)
[08:58:58.699] Timer tick, asking Buildbucket for the build status
[08:58:59.104] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:59.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:82:0) after 1m0s
[08:59:59.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:82:0)
[08:59:59.643] Timer tick, asking Buildbucket for the build status
[08:59:59.876] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:59.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:83:0) after 1m0s
[09:01:00.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:83:0)
[09:01:00.367] Timer tick, asking Buildbucket for the build status
[09:01:00.574] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:00.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:84:0) after 1m0s
[09:02:00.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:84:0)
[09:02:00.864] Timer tick, asking Buildbucket for the build status
[09:02:01.412] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:01.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:85:0) after 1m0s
[09:03:02.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:85:0)
[09:03:02.313] Timer tick, asking Buildbucket for the build status
[09:03:02.505] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:02.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:86:0) after 1m0s
[09:04:02.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:86:0)
[09:04:02.943] Timer tick, asking Buildbucket for the build status
[09:04:03.314] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:03.314] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:87:0) after 1m0s
[09:05:03.348] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:87:0)
[09:05:03.348] Timer tick, asking Buildbucket for the build status
[09:05:03.818] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:03.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:88:0) after 1m0s
[09:06:03.840] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:88:0)
[09:06:03.840] Timer tick, asking Buildbucket for the build status
[09:06:03.982] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:03.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:89:0) after 1m0s
[09:07:04.181] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:89:0)
[09:07:04.181] Timer tick, asking Buildbucket for the build status
[09:07:04.508] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:04.508] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:90:0) after 1m0s
[09:08:04.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:90:0)
[09:08:04.600] Timer tick, asking Buildbucket for the build status
[09:08:05.516] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:05.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:91:0) after 1m0s
[09:09:05.595] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:91:0)
[09:09:05.595] Timer tick, asking Buildbucket for the build status
[09:09:05.779] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:05.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:92:0) after 1m0s
[09:10:05.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:92:0)
[09:10:05.914] Timer tick, asking Buildbucket for the build status
[09:10:06.087] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:06.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:93:0) after 1m0s
[09:11:06.118] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:93:0)
[09:11:06.118] Timer tick, asking Buildbucket for the build status
[09:11:06.443] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:06.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:94:0) after 1m0s
[09:12:06.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:94:0)
[09:12:06.472] Timer tick, asking Buildbucket for the build status
[09:12:06.638] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:06.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:95:0) after 1m0s
[09:13:06.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:95:0)
[09:13:06.667] Timer tick, asking Buildbucket for the build status
[09:13:06.816] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:06.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:96:0) after 1m0s
[09:14:06.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:96:0)
[09:14:06.842] Timer tick, asking Buildbucket for the build status
[09:14:06.993] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:06.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:97:0) after 1m0s
[09:15:07.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:97:0)
[09:15:07.042] Timer tick, asking Buildbucket for the build status
[09:15:07.425] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:07.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:98:0) after 1m0s
[09:16:07.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:98:0)
[09:16:07.493] Timer tick, asking Buildbucket for the build status
[09:16:07.684] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:07.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:99:0) after 1m0s
[09:17:07.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:99:0)
[09:17:07.780] Timer tick, asking Buildbucket for the build status
[09:17:07.896] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:07.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:100:0) after 1m0s
[09:18:07.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:100:0)
[09:18:07.933] Timer tick, asking Buildbucket for the build status
[09:18:08.099] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:08.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:101:0) after 1m0s
[09:19:08.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:101:0)
[09:19:08.137] Timer tick, asking Buildbucket for the build status
[09:19:08.444] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:08.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:102:0) after 1m0s
[09:20:08.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:102:0)
[09:20:08.611] Timer tick, asking Buildbucket for the build status
[09:20:09.424] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:09.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:103:0) after 1m0s
[09:21:09.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:103:0)
[09:21:09.474] Timer tick, asking Buildbucket for the build status
[09:21:10.833] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:10.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:104:0) after 1m0s
[09:22:10.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:104:0)
[09:22:10.865] Timer tick, asking Buildbucket for the build status
[09:22:11.387] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:11.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:105:0) after 1m0s
[09:23:11.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:105:0)
[09:23:11.419] Timer tick, asking Buildbucket for the build status
[09:23:11.803] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:11.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:106:0) after 1m0s
[09:24:11.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:106:0)
[09:24:11.901] Timer tick, asking Buildbucket for the build status
[09:24:12.067] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:12.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:107:0) after 1m0s
[09:25:12.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:107:0)
[09:25:12.143] Timer tick, asking Buildbucket for the build status
[09:25:12.254] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:12.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:108:0) after 1m0s
[09:26:12.351] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:108:0)
[09:26:12.351] Timer tick, asking Buildbucket for the build status
[09:26:12.483] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:12.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:109:0) after 1m0s
[09:27:12.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:109:0)
[09:27:12.531] Timer tick, asking Buildbucket for the build status
[09:27:12.688] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:12.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:110:0) after 1m0s
[09:28:12.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:110:0)
[09:28:12.731] Timer tick, asking Buildbucket for the build status
[09:28:12.920] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:12.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:111:0) after 1m0s
[09:29:12.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:111:0)
[09:29:13.000] Timer tick, asking Buildbucket for the build status
[09:29:13.174] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:13.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:112:0) after 1m0s
[09:30:13.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:112:0)
[09:30:13.326] Timer tick, asking Buildbucket for the build status
[09:30:13.553] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:13.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:113:0) after 1m0s
[09:31:13.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:113:0)
[09:31:13.732] Timer tick, asking Buildbucket for the build status
[09:31:13.873] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:13.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:114:0) after 1m0s
[09:32:13.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:114:0)
[09:32:13.962] Timer tick, asking Buildbucket for the build status
[09:32:14.096] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:14.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:115:0) after 1m0s
[09:33:14.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:115:0)
[09:33:14.198] Timer tick, asking Buildbucket for the build status
[09:33:19.320] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:19.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:116:0) after 1m0s
[09:34:19.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:116:0)
[09:34:19.398] Timer tick, asking Buildbucket for the build status
[09:34:19.570] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:19.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:117:0) after 1m0s
[09:35:19.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:117:0)
[09:35:19.617] Timer tick, asking Buildbucket for the build status
[09:35:19.800] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:19.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:118:0) after 1m0s
[09:36:19.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:118:0)
[09:36:19.841] Timer tick, asking Buildbucket for the build status
[09:36:19.996] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:19.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:119:0) after 1m0s
[09:37:20.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:119:0)
[09:37:20.087] Timer tick, asking Buildbucket for the build status
[09:37:20.184] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:20.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:120:0) after 1m0s
[09:38:20.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:120:0)
[09:38:20.233] Timer tick, asking Buildbucket for the build status
[09:38:21.019] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:21.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:121:0) after 1m0s
[09:39:21.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:121:0)
[09:39:21.048] Timer tick, asking Buildbucket for the build status
[09:39:21.152] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:21.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:122:0) after 1m0s
[09:40:21.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:122:0)
[09:40:21.202] Timer tick, asking Buildbucket for the build status
[09:40:21.424] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:21.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:123:0) after 1m0s
[09:41:21.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:123:0)
[09:41:21.474] Timer tick, asking Buildbucket for the build status
[09:41:21.750] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:21.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:124:0) after 1m0s
[09:42:21.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:124:0)
[09:42:21.787] Timer tick, asking Buildbucket for the build status
[09:42:22.092] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:22.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:125:0) after 1m0s
[09:43:22.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:125:0)
[09:43:22.096] Timer tick, asking Buildbucket for the build status
[09:43:23.042] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:23.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:126:0) after 1m0s
[09:44:23.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:126:0)
[09:44:23.101] Timer tick, asking Buildbucket for the build status
[09:44:23.482] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:23.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:127:0) after 1m0s
[09:45:23.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:127:0)
[09:45:23.506] Timer tick, asking Buildbucket for the build status
[09:45:23.656] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:23.656] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:128:0) after 1m0s
[09:46:23.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:128:0)
[09:46:23.714] Timer tick, asking Buildbucket for the build status
[09:46:23.937] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:23.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:129:0) after 1m0s
[09:47:23.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:129:0)
[09:47:23.977] Timer tick, asking Buildbucket for the build status
[09:47:24.225] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:24.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:130:0) after 1m0s
[09:48:24.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:130:0)
[09:48:24.257] Timer tick, asking Buildbucket for the build status
[09:48:24.500] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:24.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:131:0) after 1m0s
[09:49:24.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:131:0)
[09:49:24.554] Timer tick, asking Buildbucket for the build status
[09:49:24.698] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:24.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:132:0) after 1m0s
[09:50:24.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:132:0)
[09:50:24.776] Timer tick, asking Buildbucket for the build status
[09:50:25.425] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:25.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:133:0) after 1m0s
[09:51:25.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:133:0)
[09:51:25.513] Timer tick, asking Buildbucket for the build status
[09:51:25.755] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:25.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:134:0) after 1m0s
[09:52:25.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:134:0)
[09:52:25.789] Timer tick, asking Buildbucket for the build status
[09:52:26.081] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:135:0) after 1m0s
[09:53:26.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:135:0)
[09:53:26.146] Timer tick, asking Buildbucket for the build status
[09:53:26.306] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:26.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:136:0) after 1m0s
[09:54:26.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:136:0)
[09:54:26.398] Timer tick, asking Buildbucket for the build status
[09:54:26.997] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:26.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:137:0) after 1m0s
[09:55:27.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:137:0)
[09:55:27.071] Timer tick, asking Buildbucket for the build status
[09:55:27.432] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:27.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:138:0) after 1m0s
[09:56:27.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:138:0)
[09:56:27.483] Timer tick, asking Buildbucket for the build status
[09:56:27.708] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:27.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:139:0) after 1m0s
[09:57:27.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:139:0)
[09:57:27.737] Timer tick, asking Buildbucket for the build status
[09:57:27.856] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:27.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:140:0) after 1m0s
[09:58:27.888] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:140:0)
[09:58:27.888] Timer tick, asking Buildbucket for the build status
[09:58:27.980] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:27.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:141:0) after 1m0s
[09:59:28.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:141:0)
[09:59:28.038] Timer tick, asking Buildbucket for the build status
[09:59:28.229] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:28.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:142:0) after 1m0s
[10:00:28.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:142:0)
[10:00:28.220] Timer tick, asking Buildbucket for the build status
[10:00:28.684] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:28.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:143:0) after 1m0s
[10:01:28.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:143:0)
[10:01:28.782] Timer tick, asking Buildbucket for the build status
[10:01:29.393] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:29.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:144:0) after 1m0s
[10:02:29.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:144:0)
[10:02:29.415] Timer tick, asking Buildbucket for the build status
[10:02:29.567] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:29.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:145:0) after 1m0s
[10:03:29.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:145:0)
[10:03:29.644] Timer tick, asking Buildbucket for the build status
[10:03:29.919] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:29.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:146:0) after 1m0s
[10:04:30.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:146:0)
[10:04:30.038] Timer tick, asking Buildbucket for the build status
[10:04:30.908] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:30.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:147:0) after 1m0s
[10:05:30.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:147:0)
[10:05:30.981] Timer tick, asking Buildbucket for the build status
[10:05:31.421] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:31.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:148:0) after 1m0s
[10:06:31.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:148:0)
[10:06:31.492] Timer tick, asking Buildbucket for the build status
[10:06:31.632] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:31.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:149:0) after 1m0s
[10:07:31.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:149:0)
[10:07:31.699] Timer tick, asking Buildbucket for the build status
[10:07:31.922] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:31.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:150:0) after 1m0s
[10:08:32.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:150:0)
[10:08:32.158] Timer tick, asking Buildbucket for the build status
[10:08:32.549] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:32.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:151:0) after 1m0s
[10:09:33.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:151:0)
[10:09:33.440] Timer tick, asking Buildbucket for the build status
[10:09:33.899] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:33.899] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:152:0) after 1m0s
[10:10:33.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:152:0)
[10:10:33.962] Timer tick, asking Buildbucket for the build status
[10:10:34.118] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:34.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:153:0) after 1m0s
[10:11:34.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:153:0)
[10:11:34.172] Timer tick, asking Buildbucket for the build status
[10:11:34.722] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:34.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:154:0) after 1m0s
[10:12:34.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:154:0)
[10:12:34.808] Timer tick, asking Buildbucket for the build status
[10:12:34.981] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:34.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:155:0) after 1m0s
[10:13:35.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:155:0)
[10:13:35.033] Timer tick, asking Buildbucket for the build status
[10:13:36.106] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:36.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:156:0) after 1m0s
[10:14:36.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:156:0)
[10:14:36.295] Timer tick, asking Buildbucket for the build status
[10:14:36.456] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:36.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:157:0) after 1m0s
[10:15:36.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:157:0)
[10:15:36.511] Timer tick, asking Buildbucket for the build status
[10:15:36.669] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:36.669] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:158:0) after 1m0s
[10:16:36.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:158:0)
[10:16:36.746] Timer tick, asking Buildbucket for the build status
[10:16:36.893] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:36.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:159:0) after 1m0s
[10:17:37.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:159:0)
[10:17:37.041] Timer tick, asking Buildbucket for the build status
[10:17:37.269] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:37.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:160:0) after 1m0s
[10:18:37.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:160:0)
[10:18:37.388] Timer tick, asking Buildbucket for the build status
[10:18:37.802] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:37.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:161:0) after 1m0s
[10:19:37.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:161:0)
[10:19:37.904] Timer tick, asking Buildbucket for the build status
[10:19:41.041] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:41.041] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:162:0) after 1m0s
[10:20:41.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:162:0)
[10:20:41.424] Timer tick, asking Buildbucket for the build status
[10:20:42.004] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:42.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:163:0) after 1m0s
[10:21:42.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:163:0)
[10:21:42.428] Timer tick, asking Buildbucket for the build status
[10:21:42.846] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:42.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:164:0) after 1m0s
[10:22:42.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:164:0)
[10:22:42.928] Timer tick, asking Buildbucket for the build status
[10:22:43.180] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:43.180] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:165:0) after 1m0s
[10:23:43.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:165:0)
[10:23:43.226] Timer tick, asking Buildbucket for the build status
[10:23:43.361] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:43.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:166:0) after 1m0s
[10:24:43.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:166:0)
[10:24:43.403] Timer tick, asking Buildbucket for the build status
[10:24:43.696] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:43.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:167:0) after 1m0s
[10:25:43.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:167:0)
[10:25:43.728] Timer tick, asking Buildbucket for the build status
[10:25:44.025] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:44.025] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:168:0) after 1m0s
[10:26:44.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:168:0)
[10:26:44.187] Timer tick, asking Buildbucket for the build status
[10:26:44.318] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:44.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:169:0) after 1m0s
[10:27:44.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:169:0)
[10:27:44.296] Timer tick, asking Buildbucket for the build status
[10:27:44.397] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:44.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:170:0) after 1m0s
[10:28:44.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:170:0)
[10:28:44.451] Timer tick, asking Buildbucket for the build status
[10:28:44.680] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:44.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:171:0) after 1m0s
[10:29:44.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:171:0)
[10:29:44.732] Timer tick, asking Buildbucket for the build status
[10:29:44.949] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:44.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:172:0) after 1m0s
[10:30:44.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:172:0)
[10:30:44.978] Timer tick, asking Buildbucket for the build status
[10:30:45.227] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:45.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:173:0) after 1m0s
[10:31:45.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:173:0)
[10:31:45.391] Timer tick, asking Buildbucket for the build status
[10:31:45.519] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:45.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:174:0) after 1m0s
[10:32:45.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:174:0)
[10:32:45.703] Timer tick, asking Buildbucket for the build status
[10:32:46.351] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:46.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:175:0) after 1m0s
[10:33:46.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:175:0)
[10:33:46.413] Timer tick, asking Buildbucket for the build status
[10:33:47.012] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:47.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:176:0) after 1m0s
[10:34:47.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:176:0)
[10:34:47.129] Timer tick, asking Buildbucket for the build status
[10:34:47.379] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:47.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:177:0) after 1m0s
[10:35:47.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:177:0)
[10:35:47.410] Timer tick, asking Buildbucket for the build status
[10:35:47.924] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:47.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:178:0) after 1m0s
[10:36:47.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:178:0)
[10:36:47.984] Timer tick, asking Buildbucket for the build status
[10:36:48.366] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:48.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:179:0) after 1m0s
[10:37:48.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:179:0)
[10:37:48.405] Timer tick, asking Buildbucket for the build status
[10:37:48.539] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:48.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:180:0) after 1m0s
[10:38:48.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:180:0)
[10:38:48.569] Timer tick, asking Buildbucket for the build status
[10:38:48.689] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:48.689] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:181:0) after 1m0s
[10:39:48.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:181:0)
[10:39:48.811] Timer tick, asking Buildbucket for the build status
[10:39:48.950] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:48.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:182:0) after 1m0s
[10:40:49.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:182:0)
[10:40:49.095] Timer tick, asking Buildbucket for the build status
[10:40:49.300] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:49.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:183:0) after 1m0s
[10:41:49.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:183:0)
[10:41:49.606] Timer tick, asking Buildbucket for the build status
[10:41:49.735] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:49.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:184:0) after 1m0s
[10:42:50.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:184:0)
[10:42:50.086] Timer tick, asking Buildbucket for the build status
[10:42:50.201] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:50.201] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:185:0) after 1m0s
[10:43:50.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:185:0)
[10:43:50.503] Timer tick, asking Buildbucket for the build status
[10:43:54.343] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:54.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:186:0) after 1m0s
[10:44:54.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:186:0)
[10:44:54.454] Timer tick, asking Buildbucket for the build status
[10:44:54.597] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:54.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:187:0) after 1m0s
[10:45:54.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:187:0)
[10:45:54.603] Timer tick, asking Buildbucket for the build status
[10:45:54.755] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:54.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:188:0) after 1m0s
[10:46:54.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:188:0)
[10:46:54.925] Timer tick, asking Buildbucket for the build status
[10:46:55.124] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:55.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:189:0) after 1m0s
[10:47:55.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:189:0)
[10:47:55.237] Timer tick, asking Buildbucket for the build status
[10:47:55.415] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:55.415] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:190:0) after 1m0s
[10:48:55.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:190:0)
[10:48:55.456] Timer tick, asking Buildbucket for the build status
[10:48:55.602] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:55.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:191:0) after 1m0s
[10:49:55.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:191:0)
[10:49:55.680] Timer tick, asking Buildbucket for the build status
[10:49:55.877] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:55.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:192:0) after 1m0s
[10:50:56.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:192:0)
[10:50:56.216] Timer tick, asking Buildbucket for the build status
[10:50:56.440] Build 8875360188577047056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:56.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040790250614146944:193:0) after 1m0s
[10:51:38.720] Received PubSub notification, asking Buildbucket for the build status
[10:51:38.802] Build 8875360188577047056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:51:38.802] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1594205496771868",
    "created_by": "project:infra",
    "created_ts": "1594193961507978",
    "id": "8875360188577047056",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4196.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"481279a7-6b66-401c-b1b4-a0483b018a9e\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4196.0\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-n3gq\"], \"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\": [\"5368-4b51cf5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1594193990630649",
    "status": "COMPLETED",
    "status_changed_ts": "1594205498114160",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9040790250614146944",
      "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/8875360188577047056/+/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:4d462eeefa877e10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1594205498152059",
    "url": "https://ci.chromium.org/b/8875360188577047056",
    "utcnow_ts": "1594205498795726"
  }
}
[10:51:38.802] Invocation finished in 3h12m18.620411219s with status SUCCEEDED