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

• parent_buildername:publish_tarball
• user_agent:recipe

[08:10:38.349] New invocation is queued and will start shortly
[08:10:38.349] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:10:39.815] Starting the invocation (attempt 1)
[08:10:39.867] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:10:39.867] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:10:39.867] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038523357070159136",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4220.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"813db638-82a6-4f8e-9952-b65a2b63fbee\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4220.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:9038523357070159136",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[08:10:40.297] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1596355839972530",
    "id": "8873093294704149152",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4220.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"813db638-82a6-4f8e-9952-b65a2b63fbee\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4220.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596355840151314",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038523357070159136",
      "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/8873093294704149152/+/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": "1596355840151434",
    "url": "https://ci.chromium.org/b/8873093294704149152",
    "utcnow_ts": "1596355840290404"
  }
}
[08:10:40.297] Task URL: https://ci.chromium.org/b/8873093294704149152
[08:10:40.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:2:0) after 1m0s
[08:10:44.160] Received PubSub notification, asking Buildbucket for the build status
[08:10:44.301] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:40.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:2:0)
[08:11:40.375] Timer tick, asking Buildbucket for the build status
[08:11:40.519] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:40.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:4:0) after 1m0s
[08:12:40.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:4:0)
[08:12:40.545] Timer tick, asking Buildbucket for the build status
[08:12:40.799] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:40.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:5:0) after 1m0s
[08:13:40.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:5:0)
[08:13:40.829] Timer tick, asking Buildbucket for the build status
[08:13:40.939] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:40.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:6:0) after 1m0s
[08:14:41.048] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:6:0)
[08:14:41.048] Timer tick, asking Buildbucket for the build status
[08:14:41.116] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:41.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:7:0) after 1m0s
[08:15:41.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:7:0)
[08:15:41.296] Timer tick, asking Buildbucket for the build status
[08:15:41.392] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:41.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:8:0) after 1m0s
[08:16:41.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:8:0)
[08:16:41.468] Timer tick, asking Buildbucket for the build status
[08:16:41.608] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:41.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:9:0) after 1m0s
[08:17:41.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:9:0)
[08:17:41.609] Timer tick, asking Buildbucket for the build status
[08:17:41.695] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:41.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:10:0) after 1m0s
[08:18:41.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:10:0)
[08:18:41.792] Timer tick, asking Buildbucket for the build status
[08:18:42.044] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:42.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:11:0) after 1m0s
[08:19:42.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:11:0)
[08:19:42.167] Timer tick, asking Buildbucket for the build status
[08:19:42.266] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:42.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:12:0) after 1m0s
[08:20:42.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:12:0)
[08:20:42.346] Timer tick, asking Buildbucket for the build status
[08:20:42.623] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:42.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:13:0) after 1m0s
[08:21:42.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:13:0)
[08:21:42.740] Timer tick, asking Buildbucket for the build status
[08:21:43.006] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:43.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:14:0) after 1m0s
[08:22:43.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:14:0)
[08:22:43.041] Timer tick, asking Buildbucket for the build status
[08:22:43.305] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:43.305] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:15:0) after 1m0s
[08:23:43.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:15:0)
[08:23:43.344] Timer tick, asking Buildbucket for the build status
[08:23:43.459] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:43.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:16:0) after 1m0s
[08:24:43.536] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:16:0)
[08:24:43.536] Timer tick, asking Buildbucket for the build status
[08:24:43.721] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:43.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:17:0) after 1m0s
[08:25:43.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:17:0)
[08:25:43.809] Timer tick, asking Buildbucket for the build status
[08:25:43.917] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:43.917] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:18:0) after 1m0s
[08:26:43.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:18:0)
[08:26:43.915] Timer tick, asking Buildbucket for the build status
[08:26:43.981] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:43.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:19:0) after 1m0s
[08:27:44.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:19:0)
[08:27:44.073] Timer tick, asking Buildbucket for the build status
[08:27:44.158] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:44.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:20:0) after 1m0s
[08:28:44.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:20:0)
[08:28:44.236] Timer tick, asking Buildbucket for the build status
[08:28:44.444] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:44.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:21:0) after 1m0s
[08:29:44.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:21:0)
[08:29:44.472] Timer tick, asking Buildbucket for the build status
[08:29:44.550] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:44.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:22:0) after 1m0s
[08:30:44.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:22:0)
[08:30:44.602] Timer tick, asking Buildbucket for the build status
[08:30:44.733] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:44.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:23:0) after 1m0s
[08:31:44.756] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:23:0)
[08:31:44.756] Timer tick, asking Buildbucket for the build status
[08:31:44.838] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:44.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:24:0) after 1m0s
[08:32:44.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:24:0)
[08:32:44.863] Timer tick, asking Buildbucket for the build status
[08:32:44.943] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:44.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:25:0) after 1m0s
[08:33:44.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:25:0)
[08:33:44.982] Timer tick, asking Buildbucket for the build status
[08:33:45.312] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:45.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:26:0) after 1m0s
[08:34:45.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:26:0)
[08:34:45.339] Timer tick, asking Buildbucket for the build status
[08:34:45.503] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:45.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:27:0) after 1m0s
[08:35:45.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:27:0)
[08:35:45.609] Timer tick, asking Buildbucket for the build status
[08:35:45.883] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:45.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:28:0) after 1m0s
[08:36:45.910] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:28:0)
[08:36:45.910] Timer tick, asking Buildbucket for the build status
[08:36:45.977] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:45.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:29:0) after 1m0s
[08:37:46.000] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:29:0)
[08:37:46.000] Timer tick, asking Buildbucket for the build status
[08:37:46.088] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:46.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:30:0) after 1m0s
[08:38:46.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:30:0)
[08:38:46.114] Timer tick, asking Buildbucket for the build status
[08:38:46.263] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:46.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:31:0) after 1m0s
[08:39:46.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:31:0)
[08:39:46.296] Timer tick, asking Buildbucket for the build status
[08:39:46.602] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:46.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:32:0) after 1m0s
[08:40:46.668] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:32:0)
[08:40:46.668] Timer tick, asking Buildbucket for the build status
[08:40:46.971] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:46.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:33:0) after 1m0s
[08:41:47.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:33:0)
[08:41:47.103] Timer tick, asking Buildbucket for the build status
[08:41:47.167] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:47.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:34:0) after 1m0s
[08:42:47.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:34:0)
[08:42:47.207] Timer tick, asking Buildbucket for the build status
[08:42:47.370] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:47.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:35:0) after 1m0s
[08:43:47.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:35:0)
[08:43:47.444] Timer tick, asking Buildbucket for the build status
[08:43:47.535] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:47.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:36:0) after 1m0s
[08:44:47.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:36:0)
[08:44:47.607] Timer tick, asking Buildbucket for the build status
[08:44:47.685] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:47.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:37:0) after 1m0s
[08:45:47.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:37:0)
[08:45:47.732] Timer tick, asking Buildbucket for the build status
[08:45:47.883] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:47.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:38:0) after 1m0s
[08:46:48.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:38:0)
[08:46:48.011] Timer tick, asking Buildbucket for the build status
[08:46:48.204] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:48.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:39:0) after 1m0s
[08:47:48.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:39:0)
[08:47:48.258] Timer tick, asking Buildbucket for the build status
[08:47:48.343] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:48.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:40:0) after 1m0s
[08:48:48.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:40:0)
[08:48:48.415] Timer tick, asking Buildbucket for the build status
[08:48:48.678] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:48.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:41:0) after 1m0s
[08:49:48.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:41:0)
[08:49:48.702] Timer tick, asking Buildbucket for the build status
[08:49:48.781] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:48.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:42:0) after 1m0s
[08:50:48.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:42:0)
[08:50:48.905] Timer tick, asking Buildbucket for the build status
[08:50:49.143] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:49.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:43:0) after 1m0s
[08:51:49.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:43:0)
[08:51:49.185] Timer tick, asking Buildbucket for the build status
[08:51:49.334] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:49.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:44:0) after 1m0s
[08:52:49.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:44:0)
[08:52:49.372] Timer tick, asking Buildbucket for the build status
[08:52:50.465] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:50.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:45:0) after 1m0s
[08:53:50.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:45:0)
[08:53:50.537] Timer tick, asking Buildbucket for the build status
[08:53:50.705] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:50.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:46:0) after 1m0s
[08:54:50.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:46:0)
[08:54:50.805] Timer tick, asking Buildbucket for the build status
[08:54:50.958] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:50.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:47:0) after 1m0s
[08:55:51.113] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:47:0)
[08:55:51.113] Timer tick, asking Buildbucket for the build status
[08:55:51.265] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:51.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:48:0) after 1m0s
[08:56:51.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:48:0)
[08:56:51.406] Timer tick, asking Buildbucket for the build status
[08:56:51.458] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:51.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:49:0) after 1m0s
[08:57:51.497] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:49:0)
[08:57:51.497] Timer tick, asking Buildbucket for the build status
[08:57:51.694] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:51.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:50:0) after 1m0s
[08:58:51.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:50:0)
[08:58:51.717] Timer tick, asking Buildbucket for the build status
[08:58:51.895] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:51.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:51:0) after 1m0s
[08:59:51.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:51:0)
[08:59:51.904] Timer tick, asking Buildbucket for the build status
[08:59:51.963] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:51.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:52:0) after 1m0s
[09:00:51.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:52:0)
[09:00:51.991] Timer tick, asking Buildbucket for the build status
[09:00:52.172] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:52.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:53:0) after 1m0s
[09:01:52.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:53:0)
[09:01:52.346] Timer tick, asking Buildbucket for the build status
[09:01:52.505] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:52.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:54:0) after 1m0s
[09:02:52.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:54:0)
[09:02:52.532] Timer tick, asking Buildbucket for the build status
[09:02:52.604] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:52.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:55:0) after 1m0s
[09:03:52.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:55:0)
[09:03:52.636] Timer tick, asking Buildbucket for the build status
[09:03:52.708] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:52.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:56:0) after 1m0s
[09:04:52.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:56:0)
[09:04:52.893] Timer tick, asking Buildbucket for the build status
[09:04:53.319] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:53.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:57:0) after 1m0s
[09:05:53.346] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:57:0)
[09:05:53.346] Timer tick, asking Buildbucket for the build status
[09:05:53.445] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:53.445] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:58:0) after 1m0s
[09:06:53.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:58:0)
[09:06:53.467] Timer tick, asking Buildbucket for the build status
[09:06:53.535] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:53.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:59:0) after 1m0s
[09:07:53.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:59:0)
[09:07:53.586] Timer tick, asking Buildbucket for the build status
[09:07:53.883] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:53.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:60:0) after 1m0s
[09:08:54.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:60:0)
[09:08:54.063] Timer tick, asking Buildbucket for the build status
[09:08:54.172] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:54.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:61:0) after 1m0s
[09:09:54.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:61:0)
[09:09:54.222] Timer tick, asking Buildbucket for the build status
[09:09:54.315] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:54.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:62:0) after 1m0s
[09:10:54.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:62:0)
[09:10:54.424] Timer tick, asking Buildbucket for the build status
[09:10:54.643] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:54.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:63:0) after 1m0s
[09:11:54.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:63:0)
[09:11:54.642] Timer tick, asking Buildbucket for the build status
[09:11:54.733] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:54.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:64:0) after 1m0s
[09:12:54.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:64:0)
[09:12:54.813] Timer tick, asking Buildbucket for the build status
[09:12:55.043] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:55.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:65:0) after 1m0s
[09:13:55.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:65:0)
[09:13:55.125] Timer tick, asking Buildbucket for the build status
[09:13:55.195] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:55.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:66:0) after 1m0s
[09:14:55.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:66:0)
[09:14:55.251] Timer tick, asking Buildbucket for the build status
[09:14:55.376] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:55.376] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:67:0) after 1m0s
[09:15:55.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:67:0)
[09:15:55.601] Timer tick, asking Buildbucket for the build status
[09:15:55.728] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:55.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:68:0) after 1m0s
[09:16:55.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:68:0)
[09:16:55.818] Timer tick, asking Buildbucket for the build status
[09:16:55.905] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:55.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:69:0) after 1m0s
[09:17:55.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:69:0)
[09:17:55.977] Timer tick, asking Buildbucket for the build status
[09:17:56.171] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:56.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:70:0) after 1m0s
[09:18:56.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:70:0)
[09:18:56.153] Timer tick, asking Buildbucket for the build status
[09:18:56.231] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:56.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:71:0) after 1m0s
[09:19:56.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:71:0)
[09:19:56.281] Timer tick, asking Buildbucket for the build status
[09:19:56.364] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:56.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:72:0) after 1m0s
[09:20:56.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:72:0)
[09:20:56.523] Timer tick, asking Buildbucket for the build status
[09:20:56.771] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:56.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:73:0) after 1m0s
[09:21:57.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:73:0)
[09:21:57.018] Timer tick, asking Buildbucket for the build status
[09:21:57.241] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:57.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:74:0) after 1m0s
[09:22:57.303] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:74:0)
[09:22:57.303] Timer tick, asking Buildbucket for the build status
[09:22:57.518] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:57.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:75:0) after 1m0s
[09:23:57.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:75:0)
[09:23:57.609] Timer tick, asking Buildbucket for the build status
[09:23:57.686] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:57.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:76:0) after 1m0s
[09:24:57.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:76:0)
[09:24:57.695] Timer tick, asking Buildbucket for the build status
[09:24:57.862] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:57.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:77:0) after 1m0s
[09:25:57.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:77:0)
[09:25:57.937] Timer tick, asking Buildbucket for the build status
[09:25:58.062] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:58.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:78:0) after 1m0s
[09:26:58.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:78:0)
[09:26:58.152] Timer tick, asking Buildbucket for the build status
[09:26:58.211] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:58.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:79:0) after 1m0s
[09:27:58.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:79:0)
[09:27:58.280] Timer tick, asking Buildbucket for the build status
[09:27:58.364] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:58.364] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:80:0) after 1m0s
[09:28:58.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:80:0)
[09:28:58.396] Timer tick, asking Buildbucket for the build status
[09:28:58.460] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:58.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:81:0) after 1m0s
[09:29:58.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:81:0)
[09:29:58.540] Timer tick, asking Buildbucket for the build status
[09:29:58.633] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:58.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:82:0) after 1m0s
[09:30:58.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:82:0)
[09:30:58.768] Timer tick, asking Buildbucket for the build status
[09:30:58.905] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:58.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:83:0) after 1m0s
[09:31:58.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:83:0)
[09:31:58.936] Timer tick, asking Buildbucket for the build status
[09:31:59.033] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:59.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:84:0) after 1m0s
[09:32:59.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:84:0)
[09:32:59.068] Timer tick, asking Buildbucket for the build status
[09:32:59.313] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:59.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:85:0) after 1m0s
[09:33:59.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:85:0)
[09:33:59.331] Timer tick, asking Buildbucket for the build status
[09:33:59.480] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:59.480] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:86:0) after 1m0s
[09:34:59.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:86:0)
[09:34:59.518] Timer tick, asking Buildbucket for the build status
[09:34:59.712] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:59.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:87:0) after 1m0s
[09:35:59.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:87:0)
[09:35:59.760] Timer tick, asking Buildbucket for the build status
[09:36:00.116] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:00.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:88:0) after 1m0s
[09:37:00.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:88:0)
[09:37:00.177] Timer tick, asking Buildbucket for the build status
[09:37:00.254] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:00.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:89:0) after 1m0s
[09:38:00.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:89:0)
[09:38:00.901] Timer tick, asking Buildbucket for the build status
[09:38:01.026] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:01.026] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:90:0) after 1m0s
[09:39:01.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:90:0)
[09:39:01.164] Timer tick, asking Buildbucket for the build status
[09:39:01.254] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:01.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:91:0) after 1m0s
[09:40:01.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:91:0)
[09:40:01.402] Timer tick, asking Buildbucket for the build status
[09:40:01.659] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:01.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:92:0) after 1m0s
[09:41:01.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:92:0)
[09:41:01.685] Timer tick, asking Buildbucket for the build status
[09:41:02.120] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:02.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:93:0) after 1m0s
[09:42:02.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:93:0)
[09:42:02.188] Timer tick, asking Buildbucket for the build status
[09:42:02.315] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:02.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:94:0) after 1m0s
[09:43:02.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:94:0)
[09:43:02.809] Timer tick, asking Buildbucket for the build status
[09:43:02.927] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:02.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:95:0) after 1m0s
[09:44:03.111] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:95:0)
[09:44:03.111] Timer tick, asking Buildbucket for the build status
[09:44:03.172] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:03.172] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:96:0) after 1m0s
[09:45:03.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:96:0)
[09:45:03.264] Timer tick, asking Buildbucket for the build status
[09:45:03.334] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:03.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:97:0) after 1m0s
[09:46:03.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:97:0)
[09:46:03.422] Timer tick, asking Buildbucket for the build status
[09:46:03.541] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:03.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:98:0) after 1m0s
[09:47:03.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:98:0)
[09:47:03.646] Timer tick, asking Buildbucket for the build status
[09:47:03.742] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:03.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:99:0) after 1m0s
[09:48:03.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:99:0)
[09:48:03.726] Timer tick, asking Buildbucket for the build status
[09:48:03.807] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:03.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:100:0) after 1m0s
[09:49:03.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:100:0)
[09:49:03.863] Timer tick, asking Buildbucket for the build status
[09:49:03.924] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:03.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:101:0) after 1m0s
[09:50:03.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:101:0)
[09:50:03.992] Timer tick, asking Buildbucket for the build status
[09:50:04.089] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:04.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:102:0) after 1m0s
[09:51:04.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:102:0)
[09:51:04.422] Timer tick, asking Buildbucket for the build status
[09:51:04.855] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:04.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:103:0) after 1m0s
[09:52:05.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:103:0)
[09:52:05.167] Timer tick, asking Buildbucket for the build status
[09:52:05.243] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:05.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:104:0) after 1m0s
[09:53:05.462] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:104:0)
[09:53:05.462] Timer tick, asking Buildbucket for the build status
[09:53:05.515] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:05.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:105:0) after 1m0s
[09:54:05.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:105:0)
[09:54:05.696] Timer tick, asking Buildbucket for the build status
[09:54:05.764] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:05.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:106:0) after 1m0s
[09:55:06.341] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:106:0)
[09:55:06.341] Timer tick, asking Buildbucket for the build status
[09:55:06.422] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:06.422] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:107:0) after 1m0s
[09:56:06.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:107:0)
[09:56:06.646] Timer tick, asking Buildbucket for the build status
[09:56:06.859] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:06.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:108:0) after 1m0s
[09:57:07.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:108:0)
[09:57:07.037] Timer tick, asking Buildbucket for the build status
[09:57:07.112] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:07.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:109:0) after 1m0s
[09:58:07.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:109:0)
[09:58:07.286] Timer tick, asking Buildbucket for the build status
[09:58:07.344] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:07.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:110:0) after 1m0s
[09:59:07.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:110:0)
[09:59:07.405] Timer tick, asking Buildbucket for the build status
[09:59:07.492] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:07.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:111:0) after 1m0s
[10:00:07.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:111:0)
[10:00:07.625] Timer tick, asking Buildbucket for the build status
[10:00:07.743] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:07.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:112:0) after 1m0s
[10:01:08.431] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:112:0)
[10:01:08.431] Timer tick, asking Buildbucket for the build status
[10:01:08.596] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:08.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:113:0) after 1m0s
[10:02:08.650] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:113:0)
[10:02:08.650] Timer tick, asking Buildbucket for the build status
[10:02:08.886] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:08.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:114:0) after 1m0s
[10:03:08.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:114:0)
[10:03:08.968] Timer tick, asking Buildbucket for the build status
[10:03:09.046] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:09.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:115:0) after 1m0s
[10:04:09.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:115:0)
[10:04:09.088] Timer tick, asking Buildbucket for the build status
[10:04:09.155] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:09.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:116:0) after 1m0s
[10:05:09.152] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:116:0)
[10:05:09.152] Timer tick, asking Buildbucket for the build status
[10:05:09.223] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:09.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:117:0) after 1m0s
[10:06:09.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:117:0)
[10:06:09.259] Timer tick, asking Buildbucket for the build status
[10:06:09.392] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:09.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:118:0) after 1m0s
[10:07:09.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:118:0)
[10:07:09.419] Timer tick, asking Buildbucket for the build status
[10:07:09.619] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:09.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:119:0) after 1m0s
[10:08:09.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:119:0)
[10:08:09.748] Timer tick, asking Buildbucket for the build status
[10:08:09.860] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:09.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:120:0) after 1m0s
[10:09:09.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:120:0)
[10:09:09.891] Timer tick, asking Buildbucket for the build status
[10:09:10.044] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:10.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:121:0) after 1m0s
[10:10:10.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:121:0)
[10:10:10.192] Timer tick, asking Buildbucket for the build status
[10:10:10.315] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:10.315] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:122:0) after 1m0s
[10:11:10.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:122:0)
[10:11:10.394] Timer tick, asking Buildbucket for the build status
[10:11:10.556] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:10.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:123:0) after 1m0s
[10:12:10.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:123:0)
[10:12:10.658] Timer tick, asking Buildbucket for the build status
[10:12:10.721] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:10.721] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:124:0) after 1m0s
[10:13:10.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:124:0)
[10:13:10.749] Timer tick, asking Buildbucket for the build status
[10:13:10.817] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:10.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:125:0) after 1m0s
[10:14:10.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:125:0)
[10:14:10.964] Timer tick, asking Buildbucket for the build status
[10:14:11.052] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:11.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:126:0) after 1m0s
[10:15:11.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:126:0)
[10:15:11.244] Timer tick, asking Buildbucket for the build status
[10:15:11.408] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:11.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:127:0) after 1m0s
[10:16:11.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:127:0)
[10:16:11.713] Timer tick, asking Buildbucket for the build status
[10:16:12.057] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:12.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:128:0) after 1m0s
[10:17:12.081] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:128:0)
[10:17:12.081] Timer tick, asking Buildbucket for the build status
[10:17:12.193] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:12.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:129:0) after 1m0s
[10:18:12.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:129:0)
[10:18:12.253] Timer tick, asking Buildbucket for the build status
[10:18:12.309] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:12.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:130:0) after 1m0s
[10:19:12.444] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:130:0)
[10:19:12.444] Timer tick, asking Buildbucket for the build status
[10:19:12.599] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:12.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:131:0) after 1m0s
[10:20:12.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:131:0)
[10:20:12.785] Timer tick, asking Buildbucket for the build status
[10:20:12.844] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:12.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:132:0) after 1m0s
[10:21:12.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:132:0)
[10:21:12.974] Timer tick, asking Buildbucket for the build status
[10:21:13.171] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:13.171] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:133:0) after 1m0s
[10:22:13.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:133:0)
[10:22:13.219] Timer tick, asking Buildbucket for the build status
[10:22:13.274] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:13.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:134:0) after 1m0s
[10:23:13.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:134:0)
[10:23:13.671] Timer tick, asking Buildbucket for the build status
[10:23:13.901] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:13.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:135:0) after 1m0s
[10:24:14.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:135:0)
[10:24:14.015] Timer tick, asking Buildbucket for the build status
[10:24:14.207] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:14.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:136:0) after 1m0s
[10:25:14.234] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:136:0)
[10:25:14.234] Timer tick, asking Buildbucket for the build status
[10:25:14.311] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:14.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:137:0) after 1m0s
[10:26:14.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:137:0)
[10:26:14.354] Timer tick, asking Buildbucket for the build status
[10:26:14.581] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:14.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:138:0) after 1m0s
[10:27:14.585] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:138:0)
[10:27:14.585] Timer tick, asking Buildbucket for the build status
[10:27:14.662] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:14.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:139:0) after 1m0s
[10:28:14.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:139:0)
[10:28:14.693] Timer tick, asking Buildbucket for the build status
[10:28:14.762] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:14.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:140:0) after 1m0s
[10:29:15.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:140:0)
[10:29:15.088] Timer tick, asking Buildbucket for the build status
[10:29:15.276] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:15.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:141:0) after 1m0s
[10:30:15.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:141:0)
[10:30:15.473] Timer tick, asking Buildbucket for the build status
[10:30:15.533] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:15.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:142:0) after 1m0s
[10:31:15.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:142:0)
[10:31:15.641] Timer tick, asking Buildbucket for the build status
[10:31:15.899] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:15.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:143:0) after 1m0s
[10:32:15.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:143:0)
[10:32:15.925] Timer tick, asking Buildbucket for the build status
[10:32:16.005] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:16.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:144:0) after 1m0s
[10:33:16.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:144:0)
[10:33:16.064] Timer tick, asking Buildbucket for the build status
[10:33:16.138] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:16.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:145:0) after 1m0s
[10:34:16.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:145:0)
[10:34:16.309] Timer tick, asking Buildbucket for the build status
[10:34:16.390] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:16.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:146:0) after 1m0s
[10:35:16.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:146:0)
[10:35:16.456] Timer tick, asking Buildbucket for the build status
[10:35:16.519] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:16.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:147:0) after 1m0s
[10:36:16.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:147:0)
[10:36:16.562] Timer tick, asking Buildbucket for the build status
[10:36:16.779] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:16.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:148:0) after 1m0s
[10:37:16.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:148:0)
[10:37:16.805] Timer tick, asking Buildbucket for the build status
[10:37:16.920] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:16.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:149:0) after 1m0s
[10:38:17.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:149:0)
[10:38:17.031] Timer tick, asking Buildbucket for the build status
[10:38:17.119] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:17.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:150:0) after 1m0s
[10:39:17.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:150:0)
[10:39:17.327] Timer tick, asking Buildbucket for the build status
[10:39:17.406] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:17.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:151:0) after 1m0s
[10:40:17.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:151:0)
[10:40:17.436] Timer tick, asking Buildbucket for the build status
[10:40:17.519] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:17.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:152:0) after 1m0s
[10:41:17.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:152:0)
[10:41:17.582] Timer tick, asking Buildbucket for the build status
[10:41:17.698] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:17.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:153:0) after 1m0s
[10:42:17.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:153:0)
[10:42:17.818] Timer tick, asking Buildbucket for the build status
[10:42:17.883] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:17.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:154:0) after 1m0s
[10:43:17.982] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:154:0)
[10:43:17.982] Timer tick, asking Buildbucket for the build status
[10:43:18.056] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:18.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:155:0) after 1m0s
[10:44:18.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:155:0)
[10:44:18.206] Timer tick, asking Buildbucket for the build status
[10:44:18.388] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:18.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:156:0) after 1m0s
[10:45:18.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:156:0)
[10:45:18.478] Timer tick, asking Buildbucket for the build status
[10:45:18.613] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:18.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:157:0) after 1m0s
[10:46:18.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:157:0)
[10:46:18.621] Timer tick, asking Buildbucket for the build status
[10:46:18.731] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:18.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:158:0) after 1m0s
[10:47:18.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:158:0)
[10:47:18.813] Timer tick, asking Buildbucket for the build status
[10:47:18.892] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:18.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:159:0) after 1m0s
[10:48:19.018] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:159:0)
[10:48:19.018] Timer tick, asking Buildbucket for the build status
[10:48:19.098] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:19.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:160:0) after 1m0s
[10:49:19.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:160:0)
[10:49:19.172] Timer tick, asking Buildbucket for the build status
[10:49:19.309] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:19.309] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:161:0) after 1m0s
[10:50:19.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:161:0)
[10:50:19.473] Timer tick, asking Buildbucket for the build status
[10:50:19.764] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:19.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:162:0) after 1m0s
[10:51:19.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:162:0)
[10:51:19.796] Timer tick, asking Buildbucket for the build status
[10:51:19.908] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:19.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:163:0) after 1m0s
[10:52:19.967] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:163:0)
[10:52:19.967] Timer tick, asking Buildbucket for the build status
[10:52:20.203] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:20.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:164:0) after 1m0s
[10:53:20.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:164:0)
[10:53:20.210] Timer tick, asking Buildbucket for the build status
[10:53:20.318] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:20.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:165:0) after 1m0s
[10:54:20.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:165:0)
[10:54:20.390] Timer tick, asking Buildbucket for the build status
[10:54:20.457] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:20.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:166:0) after 1m0s
[10:55:20.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:166:0)
[10:55:20.484] Timer tick, asking Buildbucket for the build status
[10:55:20.575] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:20.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:167:0) after 1m0s
[10:56:20.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:167:0)
[10:56:20.583] Timer tick, asking Buildbucket for the build status
[10:56:20.728] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:20.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:168:0) after 1m0s
[10:57:20.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:168:0)
[10:57:20.804] Timer tick, asking Buildbucket for the build status
[10:57:20.910] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:20.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:169:0) after 1m0s
[10:58:20.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:169:0)
[10:58:20.943] Timer tick, asking Buildbucket for the build status
[10:58:21.023] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:21.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:170:0) after 1m0s
[10:59:21.071] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:170:0)
[10:59:21.071] Timer tick, asking Buildbucket for the build status
[10:59:21.466] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:21.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:171:0) after 1m0s
[11:00:21.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:171:0)
[11:00:21.493] Timer tick, asking Buildbucket for the build status
[11:00:21.584] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:21.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:172:0) after 1m0s
[11:01:21.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:172:0)
[11:01:21.641] Timer tick, asking Buildbucket for the build status
[11:01:21.807] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:21.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:173:0) after 1m0s
[11:02:21.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:173:0)
[11:02:21.935] Timer tick, asking Buildbucket for the build status
[11:02:22.095] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:22.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:174:0) after 1m0s
[11:03:22.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:174:0)
[11:03:22.125] Timer tick, asking Buildbucket for the build status
[11:03:22.288] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:22.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:175:0) after 1m0s
[11:04:22.437] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:175:0)
[11:04:22.437] Timer tick, asking Buildbucket for the build status
[11:04:23.729] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:23.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:176:0) after 1m0s
[11:05:23.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:176:0)
[11:05:23.771] Timer tick, asking Buildbucket for the build status
[11:05:23.853] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:23.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:177:0) after 1m0s
[11:06:23.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:177:0)
[11:06:23.951] Timer tick, asking Buildbucket for the build status
[11:06:24.112] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:24.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:178:0) after 1m0s
[11:07:24.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:178:0)
[11:07:24.199] Timer tick, asking Buildbucket for the build status
[11:07:24.271] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:24.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:179:0) after 1m0s
[11:08:24.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:179:0)
[11:08:24.333] Timer tick, asking Buildbucket for the build status
[11:08:24.431] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:24.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:180:0) after 1m0s
[11:09:24.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:180:0)
[11:09:24.461] Timer tick, asking Buildbucket for the build status
[11:09:24.646] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:24.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:181:0) after 1m0s
[11:10:24.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:181:0)
[11:10:24.725] Timer tick, asking Buildbucket for the build status
[11:10:24.824] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:24.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:182:0) after 1m0s
[11:11:24.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:182:0)
[11:11:24.853] Timer tick, asking Buildbucket for the build status
[11:11:24.985] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:24.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:183:0) after 1m0s
[11:12:25.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:183:0)
[11:12:25.023] Timer tick, asking Buildbucket for the build status
[11:12:25.207] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:25.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:184:0) after 1m0s
[11:13:25.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:184:0)
[11:13:25.238] Timer tick, asking Buildbucket for the build status
[11:13:25.477] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:25.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:185:0) after 1m0s
[11:14:25.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:185:0)
[11:14:25.642] Timer tick, asking Buildbucket for the build status
[11:14:25.723] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:25.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:186:0) after 1m0s
[11:15:25.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:186:0)
[11:15:25.826] Timer tick, asking Buildbucket for the build status
[11:15:25.901] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:25.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:187:0) after 1m0s
[11:16:25.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:187:0)
[11:16:25.981] Timer tick, asking Buildbucket for the build status
[11:16:26.245] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:26.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:188:0) after 1m0s
[11:17:26.424] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:188:0)
[11:17:26.424] Timer tick, asking Buildbucket for the build status
[11:17:26.636] Build 8873093294704149152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:26.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038523357070159136:189:0) after 1m0s
[11:17:35.615] Received PubSub notification, asking Buildbucket for the build status
[11:17:35.758] Build 8873093294704149152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:17:35.758] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1596367054805081",
    "created_by": "project:infra",
    "created_ts": "1596355839972530",
    "id": "8873093294704149152",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4220.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"813db638-82a6-4f8e-9952-b65a2b63fbee\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4220.0\"}}",
    "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-5lc5\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5436-adf7f8a\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1596355843271643",
    "status": "COMPLETED",
    "status_changed_ts": "1596367055243249",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038523357070159136",
      "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/8873093294704149152/+/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:4dc70a9218862610",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596367055256286",
    "url": "https://ci.chromium.org/b/8873093294704149152",
    "utcnow_ts": "1596367055749376"
  }
}
[11:17:35.758] Invocation finished in 3h6m57.426707024s with status SUCCEEDED