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

• parent_buildername:publish_tarball
• user_agent:recipe

[10:40:31.487] New invocation is queued and will start shortly
[10:40:31.487] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[10:40:37.201] Starting the invocation (attempt 1)
[10:40:37.243] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:40:37.243] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:40:37.243] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9036883181685872080",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4239.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"3968fc15-e307-4d7c-85c9-db744175a1d5\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4239.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:9036883181685872080",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[10:40:37.741] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1597920037357327",
    "id": "8871453114866350384",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4239.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3968fc15-e307-4d7c-85c9-db744175a1d5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4239.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1597920037559003",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036883181685872080",
      "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/8871453114866350384/+/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": "1597920037559127",
    "url": "https://ci.chromium.org/b/8871453114866350384",
    "utcnow_ts": "1597920037734698"
  }
}
[10:40:37.741] Task URL: https://ci.chromium.org/b/8871453114866350384
[10:40:37.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:2:0) after 1m0s
[10:40:55.137] Received PubSub notification, asking Buildbucket for the build status
[10:40:55.466] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:2:0)
[10:41:37.765] Timer tick, asking Buildbucket for the build status
[10:41:37.932] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:37.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:4:0) after 1m0s
[10:42:38.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:4:0)
[10:42:38.041] Timer tick, asking Buildbucket for the build status
[10:42:38.177] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:38.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:5:0) after 1m0s
[10:43:38.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:5:0)
[10:43:38.248] Timer tick, asking Buildbucket for the build status
[10:43:38.387] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:38.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:6:0) after 1m0s
[10:44:38.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:6:0)
[10:44:38.450] Timer tick, asking Buildbucket for the build status
[10:44:38.582] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:38.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:7:0) after 1m0s
[10:45:38.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:7:0)
[10:45:38.601] Timer tick, asking Buildbucket for the build status
[10:45:38.793] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:38.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:8:0) after 1m0s
[10:46:38.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:8:0)
[10:46:38.793] Timer tick, asking Buildbucket for the build status
[10:46:38.877] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:38.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:9:0) after 1m0s
[10:47:39.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:9:0)
[10:47:39.036] Timer tick, asking Buildbucket for the build status
[10:47:39.111] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:39.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:10:0) after 1m0s
[10:48:39.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:10:0)
[10:48:39.190] Timer tick, asking Buildbucket for the build status
[10:48:39.260] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:39.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:11:0) after 1m0s
[10:49:39.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:11:0)
[10:49:39.402] Timer tick, asking Buildbucket for the build status
[10:49:39.461] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:39.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:12:0) after 1m0s
[10:50:39.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:12:0)
[10:50:39.662] Timer tick, asking Buildbucket for the build status
[10:50:39.866] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:39.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:13:0) after 1m0s
[10:51:40.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:13:0)
[10:51:40.043] Timer tick, asking Buildbucket for the build status
[10:51:40.145] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:14:0) after 1m0s
[10:52:40.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:14:0)
[10:52:40.192] Timer tick, asking Buildbucket for the build status
[10:52:40.296] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:40.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:15:0) after 1m0s
[10:53:40.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:15:0)
[10:53:40.465] Timer tick, asking Buildbucket for the build status
[10:53:40.549] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:40.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:16:0) after 1m0s
[10:54:40.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:16:0)
[10:54:40.659] Timer tick, asking Buildbucket for the build status
[10:54:40.749] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:40.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:17:0) after 1m0s
[10:55:41.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:17:0)
[10:55:41.106] Timer tick, asking Buildbucket for the build status
[10:55:41.222] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:41.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:18:0) after 1m0s
[10:56:41.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:18:0)
[10:56:41.342] Timer tick, asking Buildbucket for the build status
[10:56:41.542] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:41.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:19:0) after 1m0s
[10:57:41.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:19:0)
[10:57:41.607] Timer tick, asking Buildbucket for the build status
[10:57:42.105] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:42.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:20:0) after 1m0s
[10:58:42.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:20:0)
[10:58:42.264] Timer tick, asking Buildbucket for the build status
[10:58:42.349] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:42.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:21:0) after 1m0s
[10:59:42.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:21:0)
[10:59:42.454] Timer tick, asking Buildbucket for the build status
[10:59:42.825] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:42.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:22:0) after 1m0s
[11:00:43.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:22:0)
[11:00:43.034] Timer tick, asking Buildbucket for the build status
[11:00:43.144] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:43.144] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:23:0) after 1m0s
[11:01:43.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:23:0)
[11:01:43.167] Timer tick, asking Buildbucket for the build status
[11:01:43.391] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:43.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:24:0) after 1m0s
[11:02:43.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:24:0)
[11:02:43.420] Timer tick, asking Buildbucket for the build status
[11:02:43.561] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:43.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:25:0) after 1m0s
[11:03:43.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:25:0)
[11:03:43.613] Timer tick, asking Buildbucket for the build status
[11:03:43.667] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:43.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:26:0) after 1m0s
[11:04:43.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:26:0)
[11:04:43.713] Timer tick, asking Buildbucket for the build status
[11:04:44.087] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:44.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:27:0) after 1m0s
[11:05:44.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:27:0)
[11:05:44.274] Timer tick, asking Buildbucket for the build status
[11:05:44.441] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:44.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:28:0) after 1m0s
[11:06:44.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:28:0)
[11:06:44.464] Timer tick, asking Buildbucket for the build status
[11:06:44.557] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:44.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:29:0) after 1m0s
[11:07:44.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:29:0)
[11:07:44.580] Timer tick, asking Buildbucket for the build status
[11:07:44.657] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:44.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:30:0) after 1m0s
[11:08:44.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:30:0)
[11:08:44.698] Timer tick, asking Buildbucket for the build status
[11:08:45.015] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:45.015] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:31:0) after 1m0s
[11:09:45.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:31:0)
[11:09:45.082] Timer tick, asking Buildbucket for the build status
[11:09:45.167] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:45.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:32:0) after 1m0s
[11:10:45.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:32:0)
[11:10:45.225] Timer tick, asking Buildbucket for the build status
[11:10:45.593] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:45.593] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:33:0) after 1m0s
[11:11:45.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:33:0)
[11:11:45.635] Timer tick, asking Buildbucket for the build status
[11:11:45.735] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:45.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:34:0) after 1m0s
[11:12:45.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:34:0)
[11:12:45.830] Timer tick, asking Buildbucket for the build status
[11:12:46.981] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:46.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:35:0) after 1m0s
[11:13:47.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:35:0)
[11:13:47.068] Timer tick, asking Buildbucket for the build status
[11:13:47.345] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:47.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:36:0) after 1m0s
[11:14:47.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:36:0)
[11:14:47.423] Timer tick, asking Buildbucket for the build status
[11:14:47.491] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:47.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:37:0) after 1m0s
[11:15:47.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:37:0)
[11:15:47.593] Timer tick, asking Buildbucket for the build status
[11:15:48.036] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:48.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:38:0) after 1m0s
[11:16:48.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:38:0)
[11:16:48.086] Timer tick, asking Buildbucket for the build status
[11:16:48.153] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:48.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:39:0) after 1m0s
[11:17:48.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:39:0)
[11:17:48.215] Timer tick, asking Buildbucket for the build status
[11:17:48.486] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:48.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:40:0) after 1m0s
[11:18:48.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:40:0)
[11:18:48.545] Timer tick, asking Buildbucket for the build status
[11:18:48.651] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:48.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:41:0) after 1m0s
[11:19:48.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:41:0)
[11:19:48.689] Timer tick, asking Buildbucket for the build status
[11:19:48.803] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:48.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:42:0) after 1m0s
[11:20:48.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:42:0)
[11:20:48.829] Timer tick, asking Buildbucket for the build status
[11:20:48.981] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:48.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:43:0) after 1m0s
[11:21:49.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:43:0)
[11:21:49.007] Timer tick, asking Buildbucket for the build status
[11:21:49.315] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:49.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:44:0) after 1m0s
[11:22:49.319] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:44:0)
[11:22:49.319] Timer tick, asking Buildbucket for the build status
[11:22:49.400] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:49.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:45:0) after 1m0s
[11:23:49.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:45:0)
[11:23:49.440] Timer tick, asking Buildbucket for the build status
[11:23:49.542] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:46:0) after 1m0s
[11:24:49.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:46:0)
[11:24:49.540] Timer tick, asking Buildbucket for the build status
[11:24:49.608] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:49.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:47:0) after 1m0s
[11:25:49.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:47:0)
[11:25:49.787] Timer tick, asking Buildbucket for the build status
[11:25:49.914] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:49.914] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:48:0) after 1m0s
[11:26:50.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:48:0)
[11:26:50.005] Timer tick, asking Buildbucket for the build status
[11:26:50.129] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:49:0) after 1m0s
[11:27:50.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:49:0)
[11:27:50.119] Timer tick, asking Buildbucket for the build status
[11:27:50.251] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.251] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:50:0) after 1m0s
[11:28:50.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:50:0)
[11:28:50.256] Timer tick, asking Buildbucket for the build status
[11:28:50.354] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:50.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:51:0) after 1m0s
[11:29:50.408] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:51:0)
[11:29:50.408] Timer tick, asking Buildbucket for the build status
[11:29:50.502] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:50.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:52:0) after 1m0s
[11:30:50.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:52:0)
[11:30:50.541] Timer tick, asking Buildbucket for the build status
[11:30:50.827] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:50.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:53:0) after 1m0s
[11:31:51.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:53:0)
[11:31:51.018] Timer tick, asking Buildbucket for the build status
[11:31:51.096] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:51.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:54:0) after 1m0s
[11:32:51.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:54:0)
[11:32:51.154] Timer tick, asking Buildbucket for the build status
[11:32:51.275] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:51.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:55:0) after 1m0s
[11:33:51.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:55:0)
[11:33:51.312] Timer tick, asking Buildbucket for the build status
[11:33:51.644] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:51.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:56:0) after 1m0s
[11:34:51.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:56:0)
[11:34:51.677] Timer tick, asking Buildbucket for the build status
[11:34:51.756] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:51.756] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:57:0) after 1m0s
[11:35:51.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:57:0)
[11:35:51.781] Timer tick, asking Buildbucket for the build status
[11:35:52.184] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:52.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:58:0) after 1m0s
[11:36:52.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:58:0)
[11:36:52.226] Timer tick, asking Buildbucket for the build status
[11:36:52.298] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:52.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:59:0) after 1m0s
[11:37:52.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:59:0)
[11:37:52.325] Timer tick, asking Buildbucket for the build status
[11:37:52.398] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:52.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:60:0) after 1m0s
[11:38:52.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:60:0)
[11:38:52.423] Timer tick, asking Buildbucket for the build status
[11:38:52.624] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:52.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:61:0) after 1m0s
[11:39:52.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:61:0)
[11:39:52.651] Timer tick, asking Buildbucket for the build status
[11:39:52.717] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:52.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:62:0) after 1m0s
[11:40:52.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:62:0)
[11:40:52.739] Timer tick, asking Buildbucket for the build status
[11:40:53.045] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:53.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:63:0) after 1m0s
[11:41:53.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:63:0)
[11:41:53.243] Timer tick, asking Buildbucket for the build status
[11:41:53.317] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:53.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:64:0) after 1m0s
[11:42:53.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:64:0)
[11:42:53.302] Timer tick, asking Buildbucket for the build status
[11:42:53.613] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:53.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:65:0) after 1m0s
[11:43:53.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:65:0)
[11:43:53.746] Timer tick, asking Buildbucket for the build status
[11:43:53.810] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:53.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:66:0) after 1m0s
[11:44:53.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:66:0)
[11:44:53.909] Timer tick, asking Buildbucket for the build status
[11:44:54.039] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:54.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:67:0) after 1m0s
[11:45:54.091] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:67:0)
[11:45:54.091] Timer tick, asking Buildbucket for the build status
[11:45:54.225] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:54.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:68:0) after 1m0s
[11:46:54.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:68:0)
[11:46:54.255] Timer tick, asking Buildbucket for the build status
[11:46:54.363] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:54.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:69:0) after 1m0s
[11:47:54.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:69:0)
[11:47:54.389] Timer tick, asking Buildbucket for the build status
[11:47:54.471] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:54.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:70:0) after 1m0s
[11:48:54.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:70:0)
[11:48:54.569] Timer tick, asking Buildbucket for the build status
[11:48:54.647] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:54.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:71:0) after 1m0s
[11:49:54.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:71:0)
[11:49:54.706] Timer tick, asking Buildbucket for the build status
[11:49:54.777] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:54.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:72:0) after 1m0s
[11:50:54.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:72:0)
[11:50:54.870] Timer tick, asking Buildbucket for the build status
[11:50:55.005] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:55.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:73:0) after 1m0s
[11:51:55.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:73:0)
[11:51:55.026] Timer tick, asking Buildbucket for the build status
[11:51:55.093] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:55.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:74:0) after 1m0s
[11:52:55.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:74:0)
[11:52:55.129] Timer tick, asking Buildbucket for the build status
[11:52:55.228] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:55.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:75:0) after 1m0s
[11:53:55.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:75:0)
[11:53:55.206] Timer tick, asking Buildbucket for the build status
[11:53:55.299] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:55.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:76:0) after 1m0s
[11:54:55.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:76:0)
[11:54:55.415] Timer tick, asking Buildbucket for the build status
[11:54:55.520] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:55.520] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:77:0) after 1m0s
[11:55:55.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:77:0)
[11:55:55.577] Timer tick, asking Buildbucket for the build status
[11:55:55.678] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:55.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:78:0) after 1m0s
[11:56:55.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:78:0)
[11:56:55.689] Timer tick, asking Buildbucket for the build status
[11:56:55.768] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:55.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:79:0) after 1m0s
[11:57:55.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:79:0)
[11:57:55.799] Timer tick, asking Buildbucket for the build status
[11:57:55.855] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:55.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:80:0) after 1m0s
[11:58:55.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:80:0)
[11:58:55.993] Timer tick, asking Buildbucket for the build status
[11:58:56.088] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:56.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:81:0) after 1m0s
[11:59:56.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:81:0)
[11:59:56.229] Timer tick, asking Buildbucket for the build status
[11:59:56.428] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:56.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:82:0) after 1m0s
[12:00:56.660] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:82:0)
[12:00:56.660] Timer tick, asking Buildbucket for the build status
[12:00:56.839] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:56.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:83:0) after 1m0s
[12:01:57.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:83:0)
[12:01:57.085] Timer tick, asking Buildbucket for the build status
[12:01:57.587] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:57.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:84:0) after 1m0s
[12:02:57.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:84:0)
[12:02:57.687] Timer tick, asking Buildbucket for the build status
[12:02:57.776] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:57.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:85:0) after 1m0s
[12:03:57.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:85:0)
[12:03:57.953] Timer tick, asking Buildbucket for the build status
[12:03:58.026] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:58.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:86:0) after 1m0s
[12:04:58.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:86:0)
[12:04:58.234] Timer tick, asking Buildbucket for the build status
[12:04:58.342] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:87:0) after 1m0s
[12:05:58.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:87:0)
[12:05:58.422] Timer tick, asking Buildbucket for the build status
[12:05:58.546] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:58.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:88:0) after 1m0s
[12:06:58.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:88:0)
[12:06:58.554] Timer tick, asking Buildbucket for the build status
[12:06:58.841] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:58.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:89:0) after 1m0s
[12:07:58.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:89:0)
[12:07:58.979] Timer tick, asking Buildbucket for the build status
[12:07:59.184] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:59.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:90:0) after 1m0s
[12:08:59.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:90:0)
[12:08:59.249] Timer tick, asking Buildbucket for the build status
[12:08:59.534] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:59.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:91:0) after 1m0s
[12:09:59.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:91:0)
[12:09:59.638] Timer tick, asking Buildbucket for the build status
[12:09:59.703] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:59.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:92:0) after 1m0s
[12:10:59.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:92:0)
[12:10:59.766] Timer tick, asking Buildbucket for the build status
[12:11:00.122] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:00.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:93:0) after 1m0s
[12:12:00.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:93:0)
[12:12:00.211] Timer tick, asking Buildbucket for the build status
[12:12:00.283] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:00.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:94:0) after 1m0s
[12:13:00.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:94:0)
[12:13:00.452] Timer tick, asking Buildbucket for the build status
[12:13:00.551] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:00.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:95:0) after 1m0s
[12:14:01.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:95:0)
[12:14:01.854] Timer tick, asking Buildbucket for the build status
[12:14:02.145] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:02.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:96:0) after 1m0s
[12:15:02.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:96:0)
[12:15:02.414] Timer tick, asking Buildbucket for the build status
[12:15:02.498] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:02.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:97:0) after 1m0s
[12:16:02.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:97:0)
[12:16:02.899] Timer tick, asking Buildbucket for the build status
[12:16:03.075] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:03.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:98:0) after 1m0s
[12:17:03.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:98:0)
[12:17:03.546] Timer tick, asking Buildbucket for the build status
[12:17:03.677] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:03.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:99:0) after 1m0s
[12:18:04.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:99:0)
[12:18:04.106] Timer tick, asking Buildbucket for the build status
[12:18:04.204] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:04.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:100:0) after 1m0s
[12:19:04.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:100:0)
[12:19:04.607] Timer tick, asking Buildbucket for the build status
[12:19:04.709] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:04.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:101:0) after 1m0s
[12:20:04.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:101:0)
[12:20:04.842] Timer tick, asking Buildbucket for the build status
[12:20:04.983] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:04.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:102:0) after 1m0s
[12:21:05.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:102:0)
[12:21:05.822] Timer tick, asking Buildbucket for the build status
[12:21:05.944] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:05.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:103:0) after 1m0s
[12:22:06.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:103:0)
[12:22:06.028] Timer tick, asking Buildbucket for the build status
[12:22:06.184] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:06.184] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:104:0) after 1m0s
[12:23:06.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:104:0)
[12:23:06.245] Timer tick, asking Buildbucket for the build status
[12:23:06.532] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:06.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:105:0) after 1m0s
[12:24:06.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:105:0)
[12:24:06.532] Timer tick, asking Buildbucket for the build status
[12:24:06.628] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:06.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:106:0) after 1m0s
[12:25:06.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:106:0)
[12:25:06.712] Timer tick, asking Buildbucket for the build status
[12:25:07.095] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:07.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:107:0) after 1m0s
[12:26:07.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:107:0)
[12:26:07.212] Timer tick, asking Buildbucket for the build status
[12:26:07.434] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:07.434] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:108:0) after 1m0s
[12:27:08.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:108:0)
[12:27:08.572] Timer tick, asking Buildbucket for the build status
[12:27:08.647] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:08.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:109:0) after 1m0s
[12:28:08.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:109:0)
[12:28:08.785] Timer tick, asking Buildbucket for the build status
[12:28:08.927] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:08.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:110:0) after 1m0s
[12:29:09.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:110:0)
[12:29:09.404] Timer tick, asking Buildbucket for the build status
[12:29:09.511] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:09.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:111:0) after 1m0s
[12:30:09.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:111:0)
[12:30:09.604] Timer tick, asking Buildbucket for the build status
[12:30:09.722] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:09.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:112:0) after 1m0s
[12:31:10.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:112:0)
[12:31:10.391] Timer tick, asking Buildbucket for the build status
[12:31:10.558] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:10.558] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:113:0) after 1m0s
[12:32:10.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:113:0)
[12:32:10.820] Timer tick, asking Buildbucket for the build status
[12:32:11.168] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:11.168] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:114:0) after 1m0s
[12:33:11.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:114:0)
[12:33:11.317] Timer tick, asking Buildbucket for the build status
[12:33:11.703] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:11.703] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:115:0) after 1m0s
[12:34:11.871] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:115:0)
[12:34:11.871] Timer tick, asking Buildbucket for the build status
[12:34:11.959] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:11.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:116:0) after 1m0s
[12:35:12.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:116:0)
[12:35:12.005] Timer tick, asking Buildbucket for the build status
[12:35:12.073] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:12.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:117:0) after 1m0s
[12:36:12.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:117:0)
[12:36:12.196] Timer tick, asking Buildbucket for the build status
[12:36:12.540] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:12.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:118:0) after 1m0s
[12:37:12.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:118:0)
[12:37:12.559] Timer tick, asking Buildbucket for the build status
[12:37:12.642] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:12.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:119:0) after 1m0s
[12:38:12.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:119:0)
[12:38:12.744] Timer tick, asking Buildbucket for the build status
[12:38:12.816] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:12.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:120:0) after 1m0s
[12:39:12.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:120:0)
[12:39:12.890] Timer tick, asking Buildbucket for the build status
[12:39:12.980] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:12.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:121:0) after 1m0s
[12:40:12.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:121:0)
[12:40:12.973] Timer tick, asking Buildbucket for the build status
[12:40:13.137] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:13.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:122:0) after 1m0s
[12:41:13.283] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:122:0)
[12:41:13.283] Timer tick, asking Buildbucket for the build status
[12:41:13.517] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:13.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:123:0) after 1m0s
[12:42:13.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:123:0)
[12:42:13.640] Timer tick, asking Buildbucket for the build status
[12:42:13.722] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:13.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:124:0) after 1m0s
[12:43:13.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:124:0)
[12:43:13.777] Timer tick, asking Buildbucket for the build status
[12:43:13.876] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:13.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:125:0) after 1m0s
[12:44:13.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:125:0)
[12:44:13.938] Timer tick, asking Buildbucket for the build status
[12:44:14.053] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:14.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:126:0) after 1m0s
[12:45:14.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:126:0)
[12:45:14.083] Timer tick, asking Buildbucket for the build status
[12:45:14.154] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:14.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:127:0) after 1m0s
[12:46:14.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:127:0)
[12:46:14.235] Timer tick, asking Buildbucket for the build status
[12:46:14.351] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:14.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:128:0) after 1m0s
[12:47:14.556] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:128:0)
[12:47:14.556] Timer tick, asking Buildbucket for the build status
[12:47:14.785] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:14.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:129:0) after 1m0s
[12:48:14.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:129:0)
[12:48:14.803] Timer tick, asking Buildbucket for the build status
[12:48:15.207] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:15.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:130:0) after 1m0s
[12:49:15.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:130:0)
[12:49:15.297] Timer tick, asking Buildbucket for the build status
[12:49:15.604] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:15.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:131:0) after 1m0s
[12:50:15.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:131:0)
[12:50:15.636] Timer tick, asking Buildbucket for the build status
[12:50:15.701] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:15.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:132:0) after 1m0s
[12:51:15.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:132:0)
[12:51:15.733] Timer tick, asking Buildbucket for the build status
[12:51:15.860] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:15.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:133:0) after 1m0s
[12:52:15.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:133:0)
[12:52:15.948] Timer tick, asking Buildbucket for the build status
[12:52:16.042] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:16.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:134:0) after 1m0s
[12:53:16.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:134:0)
[12:53:16.126] Timer tick, asking Buildbucket for the build status
[12:53:16.207] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:16.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:135:0) after 1m0s
[12:54:16.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:135:0)
[12:54:16.356] Timer tick, asking Buildbucket for the build status
[12:54:16.827] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:16.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:136:0) after 1m0s
[12:55:16.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:136:0)
[12:55:16.868] Timer tick, asking Buildbucket for the build status
[12:55:17.029] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:17.029] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:137:0) after 1m0s
[12:56:17.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:137:0)
[12:56:17.033] Timer tick, asking Buildbucket for the build status
[12:56:17.139] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:17.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:138:0) after 1m0s
[12:57:17.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:138:0)
[12:57:17.206] Timer tick, asking Buildbucket for the build status
[12:57:17.372] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:17.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:139:0) after 1m0s
[12:58:17.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:139:0)
[12:58:17.403] Timer tick, asking Buildbucket for the build status
[12:58:20.518] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:20.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:140:0) after 1m0s
[12:59:20.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:140:0)
[12:59:20.554] Timer tick, asking Buildbucket for the build status
[12:59:20.690] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:20.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:141:0) after 1m0s
[13:00:20.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:141:0)
[13:00:20.729] Timer tick, asking Buildbucket for the build status
[13:00:20.848] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:20.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:142:0) after 1m0s
[13:01:20.896] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:142:0)
[13:01:20.896] Timer tick, asking Buildbucket for the build status
[13:01:21.266] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:21.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:143:0) after 1m0s
[13:02:21.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:143:0)
[13:02:21.355] Timer tick, asking Buildbucket for the build status
[13:02:21.553] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:21.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:144:0) after 1m0s
[13:03:21.614] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:144:0)
[13:03:21.614] Timer tick, asking Buildbucket for the build status
[13:03:21.686] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:21.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:145:0) after 1m0s
[13:04:21.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:145:0)
[13:04:21.758] Timer tick, asking Buildbucket for the build status
[13:04:22.513] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:22.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:146:0) after 1m0s
[13:05:22.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:146:0)
[13:05:22.584] Timer tick, asking Buildbucket for the build status
[13:05:23.219] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:23.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:147:0) after 1m0s
[13:06:23.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:147:0)
[13:06:23.247] Timer tick, asking Buildbucket for the build status
[13:06:24.071] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:24.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:148:0) after 1m0s
[13:07:24.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:148:0)
[13:07:24.129] Timer tick, asking Buildbucket for the build status
[13:07:24.193] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:24.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:149:0) after 1m0s
[13:08:24.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:149:0)
[13:08:24.232] Timer tick, asking Buildbucket for the build status
[13:08:24.327] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:24.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:150:0) after 1m0s
[13:09:24.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:150:0)
[13:09:24.361] Timer tick, asking Buildbucket for the build status
[13:09:24.866] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:24.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:151:0) after 1m0s
[13:10:24.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:151:0)
[13:10:24.928] Timer tick, asking Buildbucket for the build status
[13:10:25.240] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:25.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:152:0) after 1m0s
[13:11:25.269] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:152:0)
[13:11:25.269] Timer tick, asking Buildbucket for the build status
[13:11:25.937] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:25.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:153:0) after 1m0s
[13:12:26.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:153:0)
[13:12:26.014] Timer tick, asking Buildbucket for the build status
[13:12:26.101] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:26.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:154:0) after 1m0s
[13:13:26.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:154:0)
[13:13:26.216] Timer tick, asking Buildbucket for the build status
[13:13:26.460] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:26.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:155:0) after 1m0s
[13:14:26.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:155:0)
[13:14:26.490] Timer tick, asking Buildbucket for the build status
[13:14:26.587] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:26.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:156:0) after 1m0s
[13:15:26.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:156:0)
[13:15:26.688] Timer tick, asking Buildbucket for the build status
[13:15:26.783] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:26.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:157:0) after 1m0s
[13:16:26.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:157:0)
[13:16:26.855] Timer tick, asking Buildbucket for the build status
[13:16:27.014] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:27.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:158:0) after 1m0s
[13:17:27.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:158:0)
[13:17:27.044] Timer tick, asking Buildbucket for the build status
[13:17:27.141] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:27.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:159:0) after 1m0s
[13:18:27.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:159:0)
[13:18:27.204] Timer tick, asking Buildbucket for the build status
[13:18:27.304] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:27.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:160:0) after 1m0s
[13:19:27.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:160:0)
[13:19:27.386] Timer tick, asking Buildbucket for the build status
[13:19:27.694] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:27.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:161:0) after 1m0s
[13:20:27.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:161:0)
[13:20:27.724] Timer tick, asking Buildbucket for the build status
[13:20:27.916] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:27.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:162:0) after 1m0s
[13:21:27.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:162:0)
[13:21:27.969] Timer tick, asking Buildbucket for the build status
[13:21:28.145] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:28.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:163:0) after 1m0s
[13:22:28.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:163:0)
[13:22:28.177] Timer tick, asking Buildbucket for the build status
[13:22:28.261] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:28.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:164:0) after 1m0s
[13:23:28.299] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:164:0)
[13:23:28.299] Timer tick, asking Buildbucket for the build status
[13:23:31.826] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:31.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:165:0) after 1m0s
[13:24:31.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:165:0)
[13:24:31.856] Timer tick, asking Buildbucket for the build status
[13:24:31.972] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:31.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:166:0) after 1m0s
[13:25:32.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:166:0)
[13:25:32.000] Timer tick, asking Buildbucket for the build status
[13:25:32.142] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:32.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:167:0) after 1m0s
[13:26:32.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:167:0)
[13:26:32.274] Timer tick, asking Buildbucket for the build status
[13:26:32.395] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:32.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:168:0) after 1m0s
[13:27:32.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:168:0)
[13:27:32.535] Timer tick, asking Buildbucket for the build status
[13:27:32.707] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:32.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:169:0) after 1m0s
[13:28:32.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:169:0)
[13:28:32.727] Timer tick, asking Buildbucket for the build status
[13:28:32.809] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:32.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:170:0) after 1m0s
[13:29:32.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:170:0)
[13:29:32.885] Timer tick, asking Buildbucket for the build status
[13:29:32.963] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:32.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:171:0) after 1m0s
[13:30:32.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:171:0)
[13:30:32.976] Timer tick, asking Buildbucket for the build status
[13:30:33.048] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:33.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:172:0) after 1m0s
[13:31:33.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:172:0)
[13:31:33.088] Timer tick, asking Buildbucket for the build status
[13:31:33.278] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:33.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:173:0) after 1m0s
[13:32:33.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:173:0)
[13:32:33.326] Timer tick, asking Buildbucket for the build status
[13:32:33.477] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:33.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:174:0) after 1m0s
[13:33:33.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:174:0)
[13:33:33.497] Timer tick, asking Buildbucket for the build status
[13:33:33.726] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:33.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:175:0) after 1m0s
[13:34:33.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:175:0)
[13:34:33.836] Timer tick, asking Buildbucket for the build status
[13:34:34.449] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:34.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:176:0) after 1m0s
[13:35:34.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:176:0)
[13:35:34.483] Timer tick, asking Buildbucket for the build status
[13:35:34.587] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:34.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:177:0) after 1m0s
[13:36:34.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:177:0)
[13:36:34.648] Timer tick, asking Buildbucket for the build status
[13:36:34.766] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:34.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:178:0) after 1m0s
[13:37:34.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:178:0)
[13:37:34.816] Timer tick, asking Buildbucket for the build status
[13:37:35.231] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:35.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:179:0) after 1m0s
[13:38:35.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:179:0)
[13:38:35.214] Timer tick, asking Buildbucket for the build status
[13:38:35.591] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:35.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:180:0) after 1m0s
[13:39:35.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:180:0)
[13:39:35.726] Timer tick, asking Buildbucket for the build status
[13:39:36.696] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:36.696] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:181:0) after 1m0s
[13:40:36.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:181:0)
[13:40:36.765] Timer tick, asking Buildbucket for the build status
[13:40:36.874] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:36.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:182:0) after 1m0s
[13:41:36.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:182:0)
[13:41:36.922] Timer tick, asking Buildbucket for the build status
[13:41:37.220] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:37.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:183:0) after 1m0s
[13:42:37.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:183:0)
[13:42:37.284] Timer tick, asking Buildbucket for the build status
[13:42:37.372] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:37.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:184:0) after 1m0s
[13:43:37.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:184:0)
[13:43:37.486] Timer tick, asking Buildbucket for the build status
[13:43:37.589] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:37.589] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:185:0) after 1m0s
[13:44:37.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:185:0)
[13:44:37.689] Timer tick, asking Buildbucket for the build status
[13:44:37.764] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:37.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:186:0) after 1m0s
[13:45:37.835] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:186:0)
[13:45:37.835] Timer tick, asking Buildbucket for the build status
[13:45:38.219] Build 8871453114866350384: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:38.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9036883181685872080:187:0) after 1m0s
[13:45:54.848] Received PubSub notification, asking Buildbucket for the build status
[13:45:54.968] Build 8871453114866350384: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:45:54.968] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1597931153773715",
    "created_by": "project:infra",
    "created_ts": "1597920037357327",
    "id": "8871453114866350384",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4239.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3968fc15-e307-4d7c-85c9-db744175a1d5\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4239.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-n33d\"], \"image\": [\"chrome-xenial-20081700-d9392568d25\"], \"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\": [\"5498-3454aa6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1597920054412858",
    "status": "COMPLETED",
    "status_changed_ts": "1597931154201439",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9036883181685872080",
      "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/8871453114866350384/+/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:4e244653b1349d10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1597931154385615",
    "url": "https://ci.chromium.org/b/8871453114866350384",
    "utcnow_ts": "1597931154960379"
  }
}
[13:45:54.968] Invocation finished in 3h5m23.497931003s with status SUCCEEDED