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

• parent_buildername:publish_tarball
• user_agent:recipe

[02:25:48.805] New invocation is queued and will start shortly
[02:25:48.805] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:25:50.143] Starting the invocation (attempt 1)
[02:25:50.175] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:25:50.175] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:25:50.176] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9027311027795995312",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4342.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"a6a4322a-f93c-40d8-acfa-508dd5e6d088\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4342.3\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9027311027795995312",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[02:25:50.621] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1607048750268756",
    "id": "8861880965597467920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4342.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a6a4322a-f93c-40d8-acfa-508dd5e6d088\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4342.3\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1607048750486510",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9027311027795995312",
      "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/8861880965597467920/+/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": "1607048750486665",
    "url": "https://ci.chromium.org/b/8861880965597467920",
    "utcnow_ts": "1607048750613608"
  }
}
[02:25:50.621] Task URL: https://ci.chromium.org/b/8861880965597467920
[02:25:50.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:2:0) after 1m0s
[02:26:19.090] Received PubSub notification, asking Buildbucket for the build status
[02:26:19.186] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:50.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:2:0)
[02:26:50.664] Timer tick, asking Buildbucket for the build status
[02:26:50.744] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:50.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:4:0) after 1m0s
[02:27:50.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:4:0)
[02:27:50.764] Timer tick, asking Buildbucket for the build status
[02:27:50.859] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:50.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:5:0) after 1m0s
[02:28:50.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:5:0)
[02:28:50.916] Timer tick, asking Buildbucket for the build status
[02:28:51.345] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:51.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:6:0) after 1m0s
[02:29:51.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:6:0)
[02:29:51.372] Timer tick, asking Buildbucket for the build status
[02:29:51.487] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:51.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:7:0) after 1m0s
[02:30:51.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:7:0)
[02:30:51.582] Timer tick, asking Buildbucket for the build status
[02:30:51.875] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:51.875] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:8:0) after 1m0s
[02:31:51.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:8:0)
[02:31:51.909] Timer tick, asking Buildbucket for the build status
[02:31:52.020] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:52.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:9:0) after 1m0s
[02:32:52.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:9:0)
[02:32:52.070] Timer tick, asking Buildbucket for the build status
[02:32:52.132] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:52.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:10:0) after 1m0s
[02:33:52.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:10:0)
[02:33:52.163] Timer tick, asking Buildbucket for the build status
[02:33:52.512] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:52.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:11:0) after 1m0s
[02:34:52.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:11:0)
[02:34:52.581] Timer tick, asking Buildbucket for the build status
[02:34:52.844] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:52.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:12:0) after 1m0s
[02:35:52.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:12:0)
[02:35:52.864] Timer tick, asking Buildbucket for the build status
[02:35:53.028] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:53.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:13:0) after 1m0s
[02:36:53.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:13:0)
[02:36:53.032] Timer tick, asking Buildbucket for the build status
[02:36:53.147] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:53.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:14:0) after 1m0s
[02:37:53.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:14:0)
[02:37:53.219] Timer tick, asking Buildbucket for the build status
[02:37:53.291] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:53.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:15:0) after 1m0s
[02:38:53.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:15:0)
[02:38:53.374] Timer tick, asking Buildbucket for the build status
[02:38:53.449] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:53.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:16:0) after 1m0s
[02:39:53.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:16:0)
[02:39:53.476] Timer tick, asking Buildbucket for the build status
[02:39:53.532] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:53.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:17:0) after 1m0s
[02:40:53.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:17:0)
[02:40:53.500] Timer tick, asking Buildbucket for the build status
[02:40:53.618] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:53.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:18:0) after 1m0s
[02:41:53.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:18:0)
[02:41:53.643] Timer tick, asking Buildbucket for the build status
[02:41:53.993] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:53.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:19:0) after 1m0s
[02:42:54.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:19:0)
[02:42:54.044] Timer tick, asking Buildbucket for the build status
[02:42:54.113] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:54.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:20:0) after 1m0s
[02:43:54.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:20:0)
[02:43:54.166] Timer tick, asking Buildbucket for the build status
[02:43:54.264] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:54.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:21:0) after 1m0s
[02:44:54.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:21:0)
[02:44:54.288] Timer tick, asking Buildbucket for the build status
[02:44:54.354] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:54.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:22:0) after 1m0s
[02:45:54.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:22:0)
[02:45:54.364] Timer tick, asking Buildbucket for the build status
[02:45:54.485] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:54.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:23:0) after 1m0s
[02:46:54.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:23:0)
[02:46:54.532] Timer tick, asking Buildbucket for the build status
[02:46:54.584] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:54.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:24:0) after 1m0s
[02:47:54.633] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:24:0)
[02:47:54.633] Timer tick, asking Buildbucket for the build status
[02:47:54.702] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:54.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:25:0) after 1m0s
[02:48:54.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:25:0)
[02:48:54.735] Timer tick, asking Buildbucket for the build status
[02:48:54.813] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:54.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:26:0) after 1m0s
[02:49:54.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:26:0)
[02:49:54.838] Timer tick, asking Buildbucket for the build status
[02:49:55.133] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:55.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:27:0) after 1m0s
[02:50:55.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:27:0)
[02:50:55.247] Timer tick, asking Buildbucket for the build status
[02:50:55.448] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:55.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:28:0) after 1m0s
[02:51:55.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:28:0)
[02:51:55.498] Timer tick, asking Buildbucket for the build status
[02:51:55.999] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:55.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:29:0) after 1m0s
[02:52:56.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:29:0)
[02:52:56.314] Timer tick, asking Buildbucket for the build status
[02:52:56.371] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:56.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:30:0) after 1m0s
[02:53:56.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:30:0)
[02:53:56.530] Timer tick, asking Buildbucket for the build status
[02:53:56.600] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:56.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:31:0) after 1m0s
[02:54:56.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:31:0)
[02:54:56.805] Timer tick, asking Buildbucket for the build status
[02:54:56.873] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:56.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:32:0) after 1m0s
[02:55:56.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:32:0)
[02:55:56.885] Timer tick, asking Buildbucket for the build status
[02:55:57.043] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:57.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:33:0) after 1m0s
[02:56:57.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:33:0)
[02:56:57.117] Timer tick, asking Buildbucket for the build status
[02:56:57.198] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:57.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:34:0) after 1m0s
[02:57:57.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:34:0)
[02:57:57.202] Timer tick, asking Buildbucket for the build status
[02:57:57.282] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:57.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:35:0) after 1m0s
[02:58:57.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:35:0)
[02:58:57.790] Timer tick, asking Buildbucket for the build status
[02:58:57.853] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:57.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:36:0) after 1m0s
[02:59:58.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:36:0)
[02:59:58.015] Timer tick, asking Buildbucket for the build status
[02:59:58.121] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:58.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:37:0) after 1m0s
[03:00:58.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:37:0)
[03:00:58.271] Timer tick, asking Buildbucket for the build status
[03:00:58.834] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:58.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:38:0) after 1m0s
[03:01:59.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:38:0)
[03:01:59.044] Timer tick, asking Buildbucket for the build status
[03:01:59.107] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:59.107] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:39:0) after 1m0s
[03:02:59.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:39:0)
[03:02:59.201] Timer tick, asking Buildbucket for the build status
[03:02:59.266] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:59.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:40:0) after 1m0s
[03:03:59.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:40:0)
[03:03:59.342] Timer tick, asking Buildbucket for the build status
[03:03:59.416] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:59.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:41:0) after 1m0s
[03:04:59.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:41:0)
[03:04:59.593] Timer tick, asking Buildbucket for the build status
[03:04:59.684] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:59.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:42:0) after 1m0s
[03:05:59.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:42:0)
[03:05:59.807] Timer tick, asking Buildbucket for the build status
[03:06:00.152] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:00.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:43:0) after 1m0s
[03:07:00.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:43:0)
[03:07:00.235] Timer tick, asking Buildbucket for the build status
[03:07:00.309] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:00.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:44:0) after 1m0s
[03:08:00.699] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:44:0)
[03:08:00.699] Timer tick, asking Buildbucket for the build status
[03:08:00.769] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:00.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:45:0) after 1m0s
[03:09:00.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:45:0)
[03:09:00.823] Timer tick, asking Buildbucket for the build status
[03:09:00.939] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:00.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:46:0) after 1m0s
[03:10:02.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:46:0)
[03:10:02.231] Timer tick, asking Buildbucket for the build status
[03:10:02.387] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:02.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:47:0) after 1m0s
[03:11:02.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:47:0)
[03:11:02.514] Timer tick, asking Buildbucket for the build status
[03:11:02.609] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:02.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:48:0) after 1m0s
[03:12:02.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:48:0)
[03:12:02.729] Timer tick, asking Buildbucket for the build status
[03:12:03.521] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:03.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:49:0) after 1m0s
[03:13:03.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:49:0)
[03:13:03.557] Timer tick, asking Buildbucket for the build status
[03:13:03.824] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:03.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:50:0) after 1m0s
[03:14:04.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:50:0)
[03:14:04.042] Timer tick, asking Buildbucket for the build status
[03:14:04.173] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:04.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:51:0) after 1m0s
[03:15:04.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:51:0)
[03:15:04.641] Timer tick, asking Buildbucket for the build status
[03:15:04.712] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:04.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:52:0) after 1m0s
[03:16:04.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:52:0)
[03:16:04.800] Timer tick, asking Buildbucket for the build status
[03:16:04.918] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:04.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:53:0) after 1m0s
[03:17:05.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:53:0)
[03:17:05.062] Timer tick, asking Buildbucket for the build status
[03:17:05.281] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:05.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:54:0) after 1m0s
[03:18:05.315] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:54:0)
[03:18:05.315] Timer tick, asking Buildbucket for the build status
[03:18:05.512] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:05.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:55:0) after 1m0s
[03:19:05.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:55:0)
[03:19:05.532] Timer tick, asking Buildbucket for the build status
[03:19:05.603] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:05.603] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:56:0) after 1m0s
[03:20:05.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:56:0)
[03:20:05.667] Timer tick, asking Buildbucket for the build status
[03:20:05.760] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:05.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:57:0) after 1m0s
[03:21:05.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:57:0)
[03:21:05.847] Timer tick, asking Buildbucket for the build status
[03:21:05.969] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:05.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:58:0) after 1m0s
[03:22:06.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:58:0)
[03:22:06.071] Timer tick, asking Buildbucket for the build status
[03:22:06.193] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:06.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:59:0) after 1m0s
[03:23:06.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:59:0)
[03:23:06.226] Timer tick, asking Buildbucket for the build status
[03:23:06.297] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:06.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:60:0) after 1m0s
[03:24:06.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:60:0)
[03:24:06.368] Timer tick, asking Buildbucket for the build status
[03:24:06.599] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:06.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:61:0) after 1m0s
[03:25:06.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:61:0)
[03:25:06.647] Timer tick, asking Buildbucket for the build status
[03:25:06.721] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:06.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:62:0) after 1m0s
[03:26:06.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:62:0)
[03:26:06.779] Timer tick, asking Buildbucket for the build status
[03:26:07.003] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:07.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:63:0) after 1m0s
[03:27:07.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:63:0)
[03:27:07.019] Timer tick, asking Buildbucket for the build status
[03:27:07.099] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:07.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:64:0) after 1m0s
[03:28:07.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:64:0)
[03:28:07.164] Timer tick, asking Buildbucket for the build status
[03:28:07.374] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:07.374] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:65:0) after 1m0s
[03:29:07.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:65:0)
[03:29:07.535] Timer tick, asking Buildbucket for the build status
[03:29:07.598] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:07.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:66:0) after 1m0s
[03:30:07.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:66:0)
[03:30:07.644] Timer tick, asking Buildbucket for the build status
[03:30:07.795] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:07.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:67:0) after 1m0s
[03:31:07.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:67:0)
[03:31:07.855] Timer tick, asking Buildbucket for the build status
[03:31:08.909] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:08.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:68:0) after 1m0s
[03:32:08.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:68:0)
[03:32:08.898] Timer tick, asking Buildbucket for the build status
[03:32:08.957] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:08.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:69:0) after 1m0s
[03:33:09.009] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:69:0)
[03:33:09.009] Timer tick, asking Buildbucket for the build status
[03:33:09.205] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:09.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:70:0) after 1m0s
[03:34:09.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:70:0)
[03:34:09.260] Timer tick, asking Buildbucket for the build status
[03:34:09.548] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:09.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:71:0) after 1m0s
[03:35:09.603] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:71:0)
[03:35:09.603] Timer tick, asking Buildbucket for the build status
[03:35:09.666] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:09.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:72:0) after 1m0s
[03:36:09.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:72:0)
[03:36:09.654] Timer tick, asking Buildbucket for the build status
[03:36:09.787] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:09.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:73:0) after 1m0s
[03:37:09.860] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:73:0)
[03:37:09.860] Timer tick, asking Buildbucket for the build status
[03:37:09.936] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:09.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:74:0) after 1m0s
[03:38:09.978] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:74:0)
[03:38:09.978] Timer tick, asking Buildbucket for the build status
[03:38:10.056] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:10.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:75:0) after 1m0s
[03:39:10.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:75:0)
[03:39:10.093] Timer tick, asking Buildbucket for the build status
[03:39:10.169] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:10.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:76:0) after 1m0s
[03:40:10.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:76:0)
[03:40:10.211] Timer tick, asking Buildbucket for the build status
[03:40:10.324] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:10.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:77:0) after 1m0s
[03:41:10.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:77:0)
[03:41:10.377] Timer tick, asking Buildbucket for the build status
[03:41:10.509] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:10.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:78:0) after 1m0s
[03:42:10.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:78:0)
[03:42:10.617] Timer tick, asking Buildbucket for the build status
[03:42:10.781] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:10.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:79:0) after 1m0s
[03:43:11.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:79:0)
[03:43:11.104] Timer tick, asking Buildbucket for the build status
[03:43:11.186] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:11.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:80:0) after 1m0s
[03:44:11.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:80:0)
[03:44:11.226] Timer tick, asking Buildbucket for the build status
[03:44:11.448] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:11.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:81:0) after 1m0s
[03:45:11.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:81:0)
[03:45:11.541] Timer tick, asking Buildbucket for the build status
[03:45:11.613] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:11.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:82:0) after 1m0s
[03:46:11.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:82:0)
[03:46:11.728] Timer tick, asking Buildbucket for the build status
[03:46:11.836] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:11.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:83:0) after 1m0s
[03:47:11.965] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:83:0)
[03:47:11.965] Timer tick, asking Buildbucket for the build status
[03:47:12.038] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:12.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:84:0) after 1m0s
[03:48:12.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:84:0)
[03:48:12.276] Timer tick, asking Buildbucket for the build status
[03:48:12.795] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:12.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:85:0) after 1m0s
[03:49:12.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:85:0)
[03:49:12.818] Timer tick, asking Buildbucket for the build status
[03:49:12.944] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:12.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:86:0) after 1m0s
[03:50:12.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:86:0)
[03:50:12.993] Timer tick, asking Buildbucket for the build status
[03:50:13.122] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:13.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:87:0) after 1m0s
[03:51:13.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:87:0)
[03:51:13.163] Timer tick, asking Buildbucket for the build status
[03:51:13.327] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:13.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:88:0) after 1m0s
[03:52:13.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:88:0)
[03:52:13.394] Timer tick, asking Buildbucket for the build status
[03:52:13.815] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:13.815] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:89:0) after 1m0s
[03:53:14.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:89:0)
[03:53:14.089] Timer tick, asking Buildbucket for the build status
[03:53:14.769] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:14.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:90:0) after 1m0s
[03:54:14.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:90:0)
[03:54:14.925] Timer tick, asking Buildbucket for the build status
[03:54:14.999] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:14.999] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:91:0) after 1m0s
[03:55:15.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:91:0)
[03:55:15.199] Timer tick, asking Buildbucket for the build status
[03:55:15.268] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:15.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:92:0) after 1m0s
[03:56:15.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:92:0)
[03:56:15.389] Timer tick, asking Buildbucket for the build status
[03:56:15.483] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:15.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:93:0) after 1m0s
[03:57:15.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:93:0)
[03:57:15.614] Timer tick, asking Buildbucket for the build status
[03:57:15.691] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:15.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:94:0) after 1m0s
[03:58:15.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:94:0)
[03:58:15.801] Timer tick, asking Buildbucket for the build status
[03:58:16.122] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:16.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:95:0) after 1m0s
[03:59:16.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:95:0)
[03:59:16.283] Timer tick, asking Buildbucket for the build status
[03:59:16.428] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:16.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:96:0) after 1m0s
[04:00:16.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:96:0)
[04:00:16.588] Timer tick, asking Buildbucket for the build status
[04:00:16.820] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:16.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:97:0) after 1m0s
[04:01:16.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:97:0)
[04:01:16.916] Timer tick, asking Buildbucket for the build status
[04:01:17.085] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:17.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:98:0) after 1m0s
[04:02:17.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:98:0)
[04:02:17.197] Timer tick, asking Buildbucket for the build status
[04:02:17.289] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:17.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:99:0) after 1m0s
[04:03:17.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:99:0)
[04:03:17.511] Timer tick, asking Buildbucket for the build status
[04:03:17.569] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:17.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:100:0) after 1m0s
[04:04:17.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:100:0)
[04:04:17.596] Timer tick, asking Buildbucket for the build status
[04:04:17.912] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:17.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:101:0) after 1m0s
[04:05:17.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:101:0)
[04:05:17.937] Timer tick, asking Buildbucket for the build status
[04:05:18.087] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:18.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:102:0) after 1m0s
[04:06:18.075] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:102:0)
[04:06:18.075] Timer tick, asking Buildbucket for the build status
[04:06:18.404] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:18.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:103:0) after 1m0s
[04:07:18.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:103:0)
[04:07:18.483] Timer tick, asking Buildbucket for the build status
[04:07:18.579] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:18.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:104:0) after 1m0s
[04:08:18.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:104:0)
[04:08:18.596] Timer tick, asking Buildbucket for the build status
[04:08:18.665] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:18.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:105:0) after 1m0s
[04:09:18.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:105:0)
[04:09:18.666] Timer tick, asking Buildbucket for the build status
[04:09:18.744] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:18.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:106:0) after 1m0s
[04:10:18.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:106:0)
[04:10:18.806] Timer tick, asking Buildbucket for the build status
[04:10:19.118] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:19.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:107:0) after 1m0s
[04:11:19.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:107:0)
[04:11:19.147] Timer tick, asking Buildbucket for the build status
[04:11:19.297] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:19.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:108:0) after 1m0s
[04:12:19.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:108:0)
[04:12:19.382] Timer tick, asking Buildbucket for the build status
[04:12:19.474] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:19.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:109:0) after 1m0s
[04:13:19.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:109:0)
[04:13:19.664] Timer tick, asking Buildbucket for the build status
[04:13:19.749] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:19.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:110:0) after 1m0s
[04:14:19.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:110:0)
[04:14:19.914] Timer tick, asking Buildbucket for the build status
[04:14:19.989] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:19.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:111:0) after 1m0s
[04:15:20.136] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:111:0)
[04:15:20.136] Timer tick, asking Buildbucket for the build status
[04:15:20.947] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:20.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:112:0) after 1m0s
[04:16:21.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:112:0)
[04:16:21.038] Timer tick, asking Buildbucket for the build status
[04:16:21.625] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:21.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:113:0) after 1m0s
[04:17:21.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:113:0)
[04:17:21.756] Timer tick, asking Buildbucket for the build status
[04:17:21.817] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:21.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:114:0) after 1m0s
[04:18:21.917] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:114:0)
[04:18:21.917] Timer tick, asking Buildbucket for the build status
[04:18:22.337] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:22.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:115:0) after 1m0s
[04:19:22.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:115:0)
[04:19:22.359] Timer tick, asking Buildbucket for the build status
[04:19:22.422] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:22.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:116:0) after 1m0s
[04:20:22.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:116:0)
[04:20:22.521] Timer tick, asking Buildbucket for the build status
[04:20:22.595] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:22.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:117:0) after 1m0s
[04:21:22.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:117:0)
[04:21:22.650] Timer tick, asking Buildbucket for the build status
[04:21:22.752] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:22.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:118:0) after 1m0s
[04:22:22.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:118:0)
[04:22:22.841] Timer tick, asking Buildbucket for the build status
[04:22:22.960] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:22.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:119:0) after 1m0s
[04:23:22.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:119:0)
[04:23:22.947] Timer tick, asking Buildbucket for the build status
[04:23:23.018] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:23.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:120:0) after 1m0s
[04:24:23.049] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:120:0)
[04:24:23.049] Timer tick, asking Buildbucket for the build status
[04:24:23.117] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:23.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:121:0) after 1m0s
[04:25:23.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:121:0)
[04:25:23.191] Timer tick, asking Buildbucket for the build status
[04:25:23.260] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:23.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:122:0) after 1m0s
[04:26:23.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:122:0)
[04:26:23.286] Timer tick, asking Buildbucket for the build status
[04:26:23.423] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:23.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:123:0) after 1m0s
[04:27:23.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:123:0)
[04:27:23.488] Timer tick, asking Buildbucket for the build status
[04:27:23.554] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:23.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:124:0) after 1m0s
[04:28:23.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:124:0)
[04:28:23.637] Timer tick, asking Buildbucket for the build status
[04:28:23.720] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:23.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:125:0) after 1m0s
[04:29:23.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:125:0)
[04:29:23.765] Timer tick, asking Buildbucket for the build status
[04:29:24.127] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:24.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:126:0) after 1m0s
[04:30:24.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:126:0)
[04:30:24.274] Timer tick, asking Buildbucket for the build status
[04:30:24.358] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:24.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:127:0) after 1m0s
[04:31:24.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:127:0)
[04:31:24.432] Timer tick, asking Buildbucket for the build status
[04:31:24.562] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:24.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:128:0) after 1m0s
[04:32:24.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:128:0)
[04:32:24.627] Timer tick, asking Buildbucket for the build status
[04:32:24.699] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:24.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:129:0) after 1m0s
[04:33:24.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:129:0)
[04:33:24.739] Timer tick, asking Buildbucket for the build status
[04:33:24.904] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:24.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:130:0) after 1m0s
[04:34:25.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:130:0)
[04:34:25.015] Timer tick, asking Buildbucket for the build status
[04:34:25.095] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:25.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:131:0) after 1m0s
[04:35:25.144] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:131:0)
[04:35:25.144] Timer tick, asking Buildbucket for the build status
[04:35:25.485] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:25.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:132:0) after 1m0s
[04:36:25.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:132:0)
[04:36:25.515] Timer tick, asking Buildbucket for the build status
[04:36:25.699] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:25.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:133:0) after 1m0s
[04:37:25.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:133:0)
[04:37:25.728] Timer tick, asking Buildbucket for the build status
[04:37:25.817] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:25.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:134:0) after 1m0s
[04:38:25.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:134:0)
[04:38:25.850] Timer tick, asking Buildbucket for the build status
[04:38:25.931] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:25.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:135:0) after 1m0s
[04:39:25.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:135:0)
[04:39:25.975] Timer tick, asking Buildbucket for the build status
[04:39:26.045] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:26.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:136:0) after 1m0s
[04:40:26.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:136:0)
[04:40:26.137] Timer tick, asking Buildbucket for the build status
[04:40:26.202] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:26.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:137:0) after 1m0s
[04:41:26.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:137:0)
[04:41:26.271] Timer tick, asking Buildbucket for the build status
[04:41:26.410] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:26.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:138:0) after 1m0s
[04:42:26.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:138:0)
[04:42:26.532] Timer tick, asking Buildbucket for the build status
[04:42:26.605] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:26.605] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:139:0) after 1m0s
[04:43:26.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:139:0)
[04:43:26.686] Timer tick, asking Buildbucket for the build status
[04:43:26.783] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:26.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:140:0) after 1m0s
[04:44:27.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:140:0)
[04:44:27.178] Timer tick, asking Buildbucket for the build status
[04:44:28.766] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:28.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:141:0) after 1m0s
[04:45:28.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:141:0)
[04:45:28.792] Timer tick, asking Buildbucket for the build status
[04:45:28.872] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:28.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:142:0) after 1m0s
[04:46:28.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:142:0)
[04:46:28.967] Timer tick, asking Buildbucket for the build status
[04:46:29.118] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:29.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:143:0) after 1m0s
[04:47:29.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:143:0)
[04:47:29.147] Timer tick, asking Buildbucket for the build status
[04:47:29.247] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:29.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:144:0) after 1m0s
[04:48:29.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:144:0)
[04:48:29.364] Timer tick, asking Buildbucket for the build status
[04:48:29.478] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:29.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:145:0) after 1m0s
[04:49:29.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:145:0)
[04:49:29.604] Timer tick, asking Buildbucket for the build status
[04:49:29.679] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:29.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:146:0) after 1m0s
[04:50:29.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:146:0)
[04:50:29.727] Timer tick, asking Buildbucket for the build status
[04:50:30.009] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:30.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:147:0) after 1m0s
[04:51:30.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:147:0)
[04:51:30.048] Timer tick, asking Buildbucket for the build status
[04:51:30.185] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:30.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:148:0) after 1m0s
[04:52:30.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:148:0)
[04:52:30.227] Timer tick, asking Buildbucket for the build status
[04:52:30.285] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:30.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:149:0) after 1m0s
[04:53:30.543] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:149:0)
[04:53:30.543] Timer tick, asking Buildbucket for the build status
[04:53:30.787] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:30.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:150:0) after 1m0s
[04:54:30.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:150:0)
[04:54:30.951] Timer tick, asking Buildbucket for the build status
[04:54:31.247] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:31.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:151:0) after 1m0s
[04:55:31.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:151:0)
[04:55:31.545] Timer tick, asking Buildbucket for the build status
[04:55:31.747] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:31.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:152:0) after 1m0s
[04:56:31.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:152:0)
[04:56:31.778] Timer tick, asking Buildbucket for the build status
[04:56:31.937] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:31.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:153:0) after 1m0s
[04:57:32.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:153:0)
[04:57:32.048] Timer tick, asking Buildbucket for the build status
[04:57:32.133] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:32.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:154:0) after 1m0s
[04:58:32.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:154:0)
[04:58:32.336] Timer tick, asking Buildbucket for the build status
[04:58:32.409] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:32.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:155:0) after 1m0s
[04:59:32.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:155:0)
[04:59:32.516] Timer tick, asking Buildbucket for the build status
[04:59:32.592] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:32.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:156:0) after 1m0s
[05:00:32.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:156:0)
[05:00:32.686] Timer tick, asking Buildbucket for the build status
[05:00:33.004] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:33.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:157:0) after 1m0s
[05:01:33.042] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:157:0)
[05:01:33.042] Timer tick, asking Buildbucket for the build status
[05:01:33.213] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:33.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:158:0) after 1m0s
[05:02:33.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:158:0)
[05:02:33.317] Timer tick, asking Buildbucket for the build status
[05:02:33.390] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:33.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:159:0) after 1m0s
[05:03:33.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:159:0)
[05:03:33.460] Timer tick, asking Buildbucket for the build status
[05:03:33.824] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:33.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:160:0) after 1m0s
[05:04:33.844] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:160:0)
[05:04:33.844] Timer tick, asking Buildbucket for the build status
[05:04:34.083] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:34.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:161:0) after 1m0s
[05:05:34.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:161:0)
[05:05:34.183] Timer tick, asking Buildbucket for the build status
[05:05:34.237] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:34.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:162:0) after 1m0s
[05:06:34.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:162:0)
[05:06:34.279] Timer tick, asking Buildbucket for the build status
[05:06:34.493] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:34.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:163:0) after 1m0s
[05:07:34.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:163:0)
[05:07:34.589] Timer tick, asking Buildbucket for the build status
[05:07:34.732] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:34.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:164:0) after 1m0s
[05:08:34.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:164:0)
[05:08:34.833] Timer tick, asking Buildbucket for the build status
[05:08:34.917] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:34.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:165:0) after 1m0s
[05:09:35.076] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:165:0)
[05:09:35.076] Timer tick, asking Buildbucket for the build status
[05:09:35.139] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:35.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:166:0) after 1m0s
[05:10:35.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:166:0)
[05:10:35.241] Timer tick, asking Buildbucket for the build status
[05:10:35.311] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:35.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:167:0) after 1m0s
[05:11:35.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:167:0)
[05:11:35.325] Timer tick, asking Buildbucket for the build status
[05:11:35.424] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:35.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:168:0) after 1m0s
[05:12:35.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:168:0)
[05:12:35.520] Timer tick, asking Buildbucket for the build status
[05:12:35.599] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:35.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:169:0) after 1m0s
[05:13:35.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:169:0)
[05:13:35.708] Timer tick, asking Buildbucket for the build status
[05:13:35.783] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:35.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:170:0) after 1m0s
[05:14:35.908] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:170:0)
[05:14:35.908] Timer tick, asking Buildbucket for the build status
[05:14:35.968] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:35.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:171:0) after 1m0s
[05:15:36.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:171:0)
[05:15:36.113] Timer tick, asking Buildbucket for the build status
[05:15:36.400] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:36.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:172:0) after 1m0s
[05:16:36.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:172:0)
[05:16:36.601] Timer tick, asking Buildbucket for the build status
[05:16:36.706] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:36.706] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:173:0) after 1m0s
[05:17:36.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:173:0)
[05:17:36.739] Timer tick, asking Buildbucket for the build status
[05:17:36.808] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:36.808] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:174:0) after 1m0s
[05:18:37.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:174:0)
[05:18:37.369] Timer tick, asking Buildbucket for the build status
[05:18:37.677] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:37.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:175:0) after 1m0s
[05:19:37.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:175:0)
[05:19:37.906] Timer tick, asking Buildbucket for the build status
[05:19:37.972] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:37.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:176:0) after 1m0s
[05:20:38.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:176:0)
[05:20:38.105] Timer tick, asking Buildbucket for the build status
[05:20:38.178] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:38.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:177:0) after 1m0s
[05:21:38.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:177:0)
[05:21:38.255] Timer tick, asking Buildbucket for the build status
[05:21:38.364] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:38.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:178:0) after 1m0s
[05:22:38.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:178:0)
[05:22:38.681] Timer tick, asking Buildbucket for the build status
[05:22:38.745] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:38.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:179:0) after 1m0s
[05:23:39.067] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:179:0)
[05:23:39.067] Timer tick, asking Buildbucket for the build status
[05:23:39.127] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:39.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:180:0) after 1m0s
[05:24:39.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:180:0)
[05:24:39.314] Timer tick, asking Buildbucket for the build status
[05:24:39.370] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:39.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:181:0) after 1m0s
[05:25:39.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:181:0)
[05:25:39.674] Timer tick, asking Buildbucket for the build status
[05:25:39.733] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:39.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:182:0) after 1m0s
[05:26:39.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:182:0)
[05:26:39.858] Timer tick, asking Buildbucket for the build status
[05:26:40.022] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:40.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:183:0) after 1m0s
[05:27:40.142] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:183:0)
[05:27:40.142] Timer tick, asking Buildbucket for the build status
[05:27:40.276] Build 8861880965597467920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:40.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9027311027795995312:184:0) after 1m0s
[05:27:52.995] Received PubSub notification, asking Buildbucket for the build status
[05:27:53.059] Build 8861880965597467920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:27:53.059] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1607059672161933",
    "created_by": "project:infra",
    "created_ts": "1607048750268756",
    "id": "8861880965597467920",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4342.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a6a4322a-f93c-40d8-acfa-508dd5e6d088\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4342.3\"}}",
    "project": "infra",
    "result": "SUCCESS",
    "result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-jqh1\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1607048778142303",
    "status": "COMPLETED",
    "status_changed_ts": "1607059672748335",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9027311027795995312",
      "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/8861880965597467920/+/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:5044636ec7545910",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1607059672772264",
    "url": "https://ci.chromium.org/b/8861880965597467920",
    "utcnow_ts": "1607059673052305"
  }
}
[05:27:53.059] Invocation finished in 3h2m4.271143339s with status SUCCEEDED