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

• parent_buildername:publish_tarball
• user_agent:recipe

[05:29:50.327] New invocation is queued and will start shortly
[05:29:50.327] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[05:29:51.598] Starting the invocation (attempt 1)
[05:29:51.659] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:29:51.659] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:29:51.659] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9038805264654724208",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4183.48\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"480e9f5e-0f9f-473f-9350-d669c3900438\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4183.48\"}}",
  "pubsub_callback": {
    "auth_token": "...",
    "topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
  },
  "tags": [
    "builder:Build From Tarball",
    "scheduler_invocation_id:9038805264654724208",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[05:29:52.122] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "created_by": "project:infra",
    "created_ts": "1596086991756514",
    "id": "8873375202490276448",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.48\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"480e9f5e-0f9f-473f-9350-d669c3900438\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.48\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1596086992002799",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038805264654724208",
      "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/8873375202490276448/+/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": "1596086992002930",
    "url": "https://ci.chromium.org/b/8873375202490276448",
    "utcnow_ts": "1596086992115011"
  }
}
[05:29:52.122] Task URL: https://ci.chromium.org/b/8873375202490276448
[05:29:52.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:2:0) after 1m0s
[05:30:51.907] Received PubSub notification, asking Buildbucket for the build status
[05:30:52.236] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:52.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:2:0)
[05:30:52.619] Timer tick, asking Buildbucket for the build status
[05:30:52.723] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:52.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:4:0) after 1m0s
[05:31:52.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:4:0)
[05:31:52.769] Timer tick, asking Buildbucket for the build status
[05:31:52.939] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:52.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:5:0) after 1m0s
[05:32:52.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:5:0)
[05:32:52.966] Timer tick, asking Buildbucket for the build status
[05:32:57.418] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:57.418] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:6:0) after 1m0s
[05:33:57.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:6:0)
[05:33:57.510] Timer tick, asking Buildbucket for the build status
[05:33:57.597] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:57.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:7:0) after 1m0s
[05:34:57.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:7:0)
[05:34:57.640] Timer tick, asking Buildbucket for the build status
[05:34:57.752] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:57.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:8:0) after 1m0s
[05:35:57.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:8:0)
[05:35:57.758] Timer tick, asking Buildbucket for the build status
[05:35:57.894] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:57.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:9:0) after 1m0s
[05:36:57.936] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:9:0)
[05:36:57.936] Timer tick, asking Buildbucket for the build status
[05:36:58.018] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:58.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:10:0) after 1m0s
[05:37:58.099] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:10:0)
[05:37:58.099] Timer tick, asking Buildbucket for the build status
[05:37:58.176] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:58.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:11:0) after 1m0s
[05:38:58.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:11:0)
[05:38:58.240] Timer tick, asking Buildbucket for the build status
[05:38:58.514] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:58.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:12:0) after 1m0s
[05:39:58.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:12:0)
[05:39:58.583] Timer tick, asking Buildbucket for the build status
[05:39:58.742] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:58.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:13:0) after 1m0s
[05:40:58.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:13:0)
[05:40:58.799] Timer tick, asking Buildbucket for the build status
[05:40:58.869] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:58.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:14:0) after 1m0s
[05:41:58.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:14:0)
[05:41:58.957] Timer tick, asking Buildbucket for the build status
[05:41:59.143] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:59.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:15:0) after 1m0s
[05:42:59.137] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:15:0)
[05:42:59.137] Timer tick, asking Buildbucket for the build status
[05:42:59.229] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:59.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:16:0) after 1m0s
[05:43:59.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:16:0)
[05:43:59.407] Timer tick, asking Buildbucket for the build status
[05:43:59.498] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:59.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:17:0) after 1m0s
[05:44:59.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:17:0)
[05:44:59.531] Timer tick, asking Buildbucket for the build status
[05:45:03.631] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:03.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:18:0) after 1m0s
[05:46:03.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:18:0)
[05:46:03.816] Timer tick, asking Buildbucket for the build status
[05:46:04.054] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:04.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:19:0) after 1m0s
[05:47:04.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:19:0)
[05:47:04.330] Timer tick, asking Buildbucket for the build status
[05:47:04.412] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:04.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:20:0) after 1m0s
[05:48:04.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:20:0)
[05:48:04.517] Timer tick, asking Buildbucket for the build status
[05:48:04.715] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:04.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:21:0) after 1m0s
[05:49:04.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:21:0)
[05:49:04.811] Timer tick, asking Buildbucket for the build status
[05:49:05.087] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:05.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:22:0) after 1m0s
[05:50:05.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:22:0)
[05:50:05.129] Timer tick, asking Buildbucket for the build status
[05:50:05.248] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:05.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:23:0) after 1m0s
[05:51:05.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:23:0)
[05:51:05.337] Timer tick, asking Buildbucket for the build status
[05:51:05.440] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:05.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:24:0) after 1m0s
[05:52:05.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:24:0)
[05:52:05.622] Timer tick, asking Buildbucket for the build status
[05:52:05.864] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:05.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:25:0) after 1m0s
[05:53:05.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:25:0)
[05:53:05.962] Timer tick, asking Buildbucket for the build status
[05:53:06.083] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:06.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:26:0) after 1m0s
[05:54:06.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:26:0)
[05:54:06.225] Timer tick, asking Buildbucket for the build status
[05:54:06.284] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:06.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:27:0) after 1m0s
[05:55:06.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:27:0)
[05:55:06.380] Timer tick, asking Buildbucket for the build status
[05:55:06.498] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:06.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:28:0) after 1m0s
[05:56:06.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:28:0)
[05:56:06.569] Timer tick, asking Buildbucket for the build status
[05:56:06.652] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:06.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:29:0) after 1m0s
[05:57:06.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:29:0)
[05:57:06.692] Timer tick, asking Buildbucket for the build status
[05:57:06.768] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:06.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:30:0) after 1m0s
[05:58:06.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:30:0)
[05:58:06.810] Timer tick, asking Buildbucket for the build status
[05:58:08.565] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:08.565] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:31:0) after 1m0s
[05:59:08.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:31:0)
[05:59:08.604] Timer tick, asking Buildbucket for the build status
[05:59:08.720] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:08.720] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:32:0) after 1m0s
[06:00:08.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:32:0)
[06:00:08.794] Timer tick, asking Buildbucket for the build status
[06:00:09.385] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:09.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:33:0) after 1m0s
[06:01:09.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:33:0)
[06:01:09.476] Timer tick, asking Buildbucket for the build status
[06:01:09.557] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:09.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:34:0) after 1m0s
[06:02:09.604] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:34:0)
[06:02:09.604] Timer tick, asking Buildbucket for the build status
[06:02:09.708] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:09.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:35:0) after 1m0s
[06:03:09.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:35:0)
[06:03:09.842] Timer tick, asking Buildbucket for the build status
[06:03:10.169] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:10.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:36:0) after 1m0s
[06:04:10.220] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:36:0)
[06:04:10.220] Timer tick, asking Buildbucket for the build status
[06:04:10.475] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:10.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:37:0) after 1m0s
[06:05:10.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:37:0)
[06:05:10.591] Timer tick, asking Buildbucket for the build status
[06:05:10.781] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:10.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:38:0) after 1m0s
[06:06:10.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:38:0)
[06:06:10.882] Timer tick, asking Buildbucket for the build status
[06:06:11.054] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:11.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:39:0) after 1m0s
[06:07:11.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:39:0)
[06:07:11.038] Timer tick, asking Buildbucket for the build status
[06:07:11.148] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:11.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:40:0) after 1m0s
[06:08:11.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:40:0)
[06:08:11.196] Timer tick, asking Buildbucket for the build status
[06:08:11.324] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:11.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:41:0) after 1m0s
[06:09:11.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:41:0)
[06:09:11.467] Timer tick, asking Buildbucket for the build status
[06:09:11.584] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:11.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:42:0) after 1m0s
[06:10:11.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:42:0)
[06:10:11.708] Timer tick, asking Buildbucket for the build status
[06:10:11.843] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:11.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:43:0) after 1m0s
[06:11:11.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:43:0)
[06:11:11.986] Timer tick, asking Buildbucket for the build status
[06:11:12.055] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:12.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:44:0) after 1m0s
[06:12:12.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:44:0)
[06:12:12.196] Timer tick, asking Buildbucket for the build status
[06:12:12.410] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:12.410] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:45:0) after 1m0s
[06:13:12.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:45:0)
[06:13:12.452] Timer tick, asking Buildbucket for the build status
[06:13:12.545] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:12.545] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:46:0) after 1m0s
[06:14:12.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:46:0)
[06:14:12.639] Timer tick, asking Buildbucket for the build status
[06:14:12.749] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:12.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:47:0) after 1m0s
[06:15:12.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:47:0)
[06:15:12.817] Timer tick, asking Buildbucket for the build status
[06:15:13.739] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:13.739] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:48:0) after 1m0s
[06:16:13.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:48:0)
[06:16:13.771] Timer tick, asking Buildbucket for the build status
[06:16:13.876] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:13.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:49:0) after 1m0s
[06:17:13.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:49:0)
[06:17:13.995] Timer tick, asking Buildbucket for the build status
[06:17:14.365] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:14.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:50:0) after 1m0s
[06:18:14.430] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:50:0)
[06:18:14.430] Timer tick, asking Buildbucket for the build status
[06:18:14.541] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:14.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:51:0) after 1m0s
[06:19:14.617] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:51:0)
[06:19:14.617] Timer tick, asking Buildbucket for the build status
[06:19:14.695] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:14.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:52:0) after 1m0s
[06:20:14.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:52:0)
[06:20:14.764] Timer tick, asking Buildbucket for the build status
[06:20:14.927] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:14.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:53:0) after 1m0s
[06:21:14.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:53:0)
[06:21:14.907] Timer tick, asking Buildbucket for the build status
[06:21:14.981] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:14.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:54:0) after 1m0s
[06:22:15.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:54:0)
[06:22:15.107] Timer tick, asking Buildbucket for the build status
[06:22:15.510] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:15.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:55:0) after 1m0s
[06:23:15.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:55:0)
[06:23:15.562] Timer tick, asking Buildbucket for the build status
[06:23:15.804] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:15.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:56:0) after 1m0s
[06:24:15.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:56:0)
[06:24:15.902] Timer tick, asking Buildbucket for the build status
[06:24:16.091] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:16.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:57:0) after 1m0s
[06:25:16.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:57:0)
[06:25:16.101] Timer tick, asking Buildbucket for the build status
[06:25:16.234] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:16.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:58:0) after 1m0s
[06:26:16.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:58:0)
[06:26:16.257] Timer tick, asking Buildbucket for the build status
[06:26:16.372] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:16.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:59:0) after 1m0s
[06:27:16.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:59:0)
[06:27:16.458] Timer tick, asking Buildbucket for the build status
[06:27:19.950] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:19.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:60:0) after 1m0s
[06:28:20.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:60:0)
[06:28:20.064] Timer tick, asking Buildbucket for the build status
[06:28:20.560] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:20.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:61:0) after 1m0s
[06:29:20.646] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:61:0)
[06:29:20.646] Timer tick, asking Buildbucket for the build status
[06:29:20.734] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:20.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:62:0) after 1m0s
[06:30:20.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:62:0)
[06:30:20.776] Timer tick, asking Buildbucket for the build status
[06:30:21.152] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:21.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:63:0) after 1m0s
[06:31:21.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:63:0)
[06:31:21.191] Timer tick, asking Buildbucket for the build status
[06:31:21.528] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:21.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:64:0) after 1m0s
[06:32:21.636] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:64:0)
[06:32:21.636] Timer tick, asking Buildbucket for the build status
[06:32:21.704] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:21.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:65:0) after 1m0s
[06:33:21.772] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:65:0)
[06:33:21.772] Timer tick, asking Buildbucket for the build status
[06:33:22.938] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:22.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:66:0) after 1m0s
[06:34:23.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:66:0)
[06:34:23.093] Timer tick, asking Buildbucket for the build status
[06:34:23.198] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:23.198] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:67:0) after 1m0s
[06:35:23.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:67:0)
[06:35:23.304] Timer tick, asking Buildbucket for the build status
[06:35:23.454] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:23.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:68:0) after 1m0s
[06:36:23.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:68:0)
[06:36:23.546] Timer tick, asking Buildbucket for the build status
[06:36:23.608] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:23.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:69:0) after 1m0s
[06:37:23.726] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:69:0)
[06:37:23.726] Timer tick, asking Buildbucket for the build status
[06:37:23.806] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:23.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:70:0) after 1m0s
[06:38:23.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:70:0)
[06:38:23.933] Timer tick, asking Buildbucket for the build status
[06:38:24.028] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:24.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:71:0) after 1m0s
[06:39:24.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:71:0)
[06:39:24.120] Timer tick, asking Buildbucket for the build status
[06:39:24.936] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:24.936] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:72:0) after 1m0s
[06:40:25.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:72:0)
[06:40:25.154] Timer tick, asking Buildbucket for the build status
[06:40:25.296] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:25.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:73:0) after 1m0s
[06:41:25.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:73:0)
[06:41:25.339] Timer tick, asking Buildbucket for the build status
[06:41:25.564] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:25.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:74:0) after 1m0s
[06:42:25.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:74:0)
[06:42:25.624] Timer tick, asking Buildbucket for the build status
[06:42:25.866] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:25.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:75:0) after 1m0s
[06:43:25.904] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:75:0)
[06:43:25.904] Timer tick, asking Buildbucket for the build status
[06:43:25.984] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:25.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:76:0) after 1m0s
[06:44:26.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:76:0)
[06:44:26.029] Timer tick, asking Buildbucket for the build status
[06:44:26.403] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:26.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:77:0) after 1m0s
[06:45:26.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:77:0)
[06:45:26.419] Timer tick, asking Buildbucket for the build status
[06:45:26.562] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:26.562] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:78:0) after 1m0s
[06:46:26.637] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:78:0)
[06:46:26.637] Timer tick, asking Buildbucket for the build status
[06:46:26.834] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:26.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:79:0) after 1m0s
[06:47:26.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:79:0)
[06:47:26.893] Timer tick, asking Buildbucket for the build status
[06:47:26.992] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:26.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:80:0) after 1m0s
[06:48:27.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:80:0)
[06:48:27.077] Timer tick, asking Buildbucket for the build status
[06:48:27.194] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:27.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:81:0) after 1m0s
[06:49:27.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:81:0)
[06:49:27.251] Timer tick, asking Buildbucket for the build status
[06:49:29.158] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:29.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:82:0) after 1m0s
[06:50:29.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:82:0)
[06:50:29.197] Timer tick, asking Buildbucket for the build status
[06:50:29.705] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:29.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:83:0) after 1m0s
[06:51:29.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:83:0)
[06:51:29.830] Timer tick, asking Buildbucket for the build status
[06:51:29.923] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:29.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:84:0) after 1m0s
[06:52:29.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:84:0)
[06:52:29.994] Timer tick, asking Buildbucket for the build status
[06:52:30.159] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:30.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:85:0) after 1m0s
[06:53:30.222] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:85:0)
[06:53:30.222] Timer tick, asking Buildbucket for the build status
[06:53:30.379] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:30.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:86:0) after 1m0s
[06:54:30.443] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:86:0)
[06:54:30.443] Timer tick, asking Buildbucket for the build status
[06:54:30.514] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:30.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:87:0) after 1m0s
[06:55:30.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:87:0)
[06:55:30.587] Timer tick, asking Buildbucket for the build status
[06:55:30.705] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:30.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:88:0) after 1m0s
[06:56:30.763] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:88:0)
[06:56:30.763] Timer tick, asking Buildbucket for the build status
[06:56:30.863] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:30.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:89:0) after 1m0s
[06:57:30.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:89:0)
[06:57:30.901] Timer tick, asking Buildbucket for the build status
[06:57:30.968] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:30.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:90:0) after 1m0s
[06:58:31.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:90:0)
[06:58:31.017] Timer tick, asking Buildbucket for the build status
[06:58:33.864] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:33.864] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:91:0) after 1m0s
[06:59:33.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:91:0)
[06:59:33.900] Timer tick, asking Buildbucket for the build status
[06:59:34.000] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:34.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:92:0) after 1m0s
[07:00:34.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:92:0)
[07:00:34.041] Timer tick, asking Buildbucket for the build status
[07:00:34.219] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:34.219] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:93:0) after 1m0s
[07:01:34.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:93:0)
[07:01:34.371] Timer tick, asking Buildbucket for the build status
[07:01:34.544] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:34.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:94:0) after 1m0s
[07:02:34.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:94:0)
[07:02:34.669] Timer tick, asking Buildbucket for the build status
[07:02:34.855] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:34.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:95:0) after 1m0s
[07:03:34.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:95:0)
[07:03:34.946] Timer tick, asking Buildbucket for the build status
[07:03:35.145] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:35.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:96:0) after 1m0s
[07:04:35.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:96:0)
[07:04:35.190] Timer tick, asking Buildbucket for the build status
[07:04:35.352] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:35.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:97:0) after 1m0s
[07:05:35.404] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:97:0)
[07:05:35.404] Timer tick, asking Buildbucket for the build status
[07:05:35.711] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:35.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:98:0) after 1m0s
[07:06:35.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:98:0)
[07:06:35.738] Timer tick, asking Buildbucket for the build status
[07:06:35.820] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:35.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:99:0) after 1m0s
[07:07:35.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:99:0)
[07:07:35.870] Timer tick, asking Buildbucket for the build status
[07:07:35.947] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:35.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:100:0) after 1m0s
[07:08:36.028] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:100:0)
[07:08:36.028] Timer tick, asking Buildbucket for the build status
[07:08:36.133] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:36.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:101:0) after 1m0s
[07:09:36.187] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:101:0)
[07:09:36.187] Timer tick, asking Buildbucket for the build status
[07:09:37.225] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:37.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:102:0) after 1m0s
[07:10:37.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:102:0)
[07:10:37.388] Timer tick, asking Buildbucket for the build status
[07:10:44.631] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:44.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:103:0) after 1m0s
[07:11:44.804] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:103:0)
[07:11:44.804] Timer tick, asking Buildbucket for the build status
[07:11:44.890] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:44.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:104:0) after 1m0s
[07:12:44.945] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:104:0)
[07:12:44.945] Timer tick, asking Buildbucket for the build status
[07:12:45.178] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:45.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:105:0) after 1m0s
[07:13:45.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:105:0)
[07:13:45.244] Timer tick, asking Buildbucket for the build status
[07:13:47.798] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:47.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:106:0) after 1m0s
[07:14:47.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:106:0)
[07:14:47.883] Timer tick, asking Buildbucket for the build status
[07:14:47.980] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:47.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:107:0) after 1m0s
[07:15:48.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:107:0)
[07:15:48.094] Timer tick, asking Buildbucket for the build status
[07:15:48.218] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:48.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:108:0) after 1m0s
[07:16:48.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:108:0)
[07:16:48.231] Timer tick, asking Buildbucket for the build status
[07:16:48.373] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:48.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:109:0) after 1m0s
[07:17:48.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:109:0)
[07:17:48.507] Timer tick, asking Buildbucket for the build status
[07:17:48.788] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:48.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:110:0) after 1m0s
[07:18:48.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:110:0)
[07:18:48.853] Timer tick, asking Buildbucket for the build status
[07:18:48.940] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:48.940] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:111:0) after 1m0s
[07:19:48.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:111:0)
[07:19:48.939] Timer tick, asking Buildbucket for the build status
[07:19:49.021] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:49.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:112:0) after 1m0s
[07:20:49.044] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:112:0)
[07:20:49.044] Timer tick, asking Buildbucket for the build status
[07:20:49.200] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:49.200] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:113:0) after 1m0s
[07:21:49.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:113:0)
[07:21:49.237] Timer tick, asking Buildbucket for the build status
[07:21:49.349] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:49.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:114:0) after 1m0s
[07:22:49.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:114:0)
[07:22:49.396] Timer tick, asking Buildbucket for the build status
[07:22:49.528] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:49.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:115:0) after 1m0s
[07:23:49.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:115:0)
[07:23:49.560] Timer tick, asking Buildbucket for the build status
[07:23:49.793] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:49.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:116:0) after 1m0s
[07:24:49.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:116:0)
[07:24:49.809] Timer tick, asking Buildbucket for the build status
[07:24:49.908] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:49.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:117:0) after 1m0s
[07:25:49.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:117:0)
[07:25:49.983] Timer tick, asking Buildbucket for the build status
[07:25:50.189] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:50.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:118:0) after 1m0s
[07:26:50.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:118:0)
[07:26:50.236] Timer tick, asking Buildbucket for the build status
[07:26:50.489] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:50.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:119:0) after 1m0s
[07:27:50.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:119:0)
[07:27:50.517] Timer tick, asking Buildbucket for the build status
[07:27:54.006] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:54.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:120:0) after 1m0s
[07:28:54.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:120:0)
[07:28:54.034] Timer tick, asking Buildbucket for the build status
[07:28:54.118] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:54.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:121:0) after 1m0s
[07:29:54.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:121:0)
[07:29:54.147] Timer tick, asking Buildbucket for the build status
[07:29:54.247] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:54.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:122:0) after 1m0s
[07:30:54.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:122:0)
[07:30:54.287] Timer tick, asking Buildbucket for the build status
[07:30:54.438] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:54.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:123:0) after 1m0s
[07:31:54.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:123:0)
[07:31:54.463] Timer tick, asking Buildbucket for the build status
[07:31:54.907] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:54.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:124:0) after 1m0s
[07:32:55.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:124:0)
[07:32:55.011] Timer tick, asking Buildbucket for the build status
[07:32:55.281] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:55.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:125:0) after 1m0s
[07:33:55.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:125:0)
[07:33:55.310] Timer tick, asking Buildbucket for the build status
[07:33:55.464] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:55.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:126:0) after 1m0s
[07:34:55.489] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:126:0)
[07:34:55.489] Timer tick, asking Buildbucket for the build status
[07:34:55.995] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:55.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:127:0) after 1m0s
[07:35:56.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:127:0)
[07:35:56.041] Timer tick, asking Buildbucket for the build status
[07:35:56.176] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:56.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:128:0) after 1m0s
[07:36:56.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:128:0)
[07:36:56.213] Timer tick, asking Buildbucket for the build status
[07:36:56.269] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:56.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:129:0) after 1m0s
[07:37:56.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:129:0)
[07:37:56.286] Timer tick, asking Buildbucket for the build status
[07:37:56.475] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:56.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:130:0) after 1m0s
[07:38:56.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:130:0)
[07:38:56.584] Timer tick, asking Buildbucket for the build status
[07:38:56.650] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:56.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:131:0) after 1m0s
[07:39:56.687] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:131:0)
[07:39:56.687] Timer tick, asking Buildbucket for the build status
[07:39:56.760] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:56.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:132:0) after 1m0s
[07:40:56.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:132:0)
[07:40:56.853] Timer tick, asking Buildbucket for the build status
[07:40:56.976] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:56.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:133:0) after 1m0s
[07:41:57.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:133:0)
[07:41:57.036] Timer tick, asking Buildbucket for the build status
[07:41:57.117] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:57.117] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:134:0) after 1m0s
[07:42:57.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:134:0)
[07:42:57.124] Timer tick, asking Buildbucket for the build status
[07:42:57.214] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:57.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:135:0) after 1m0s
[07:43:57.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:135:0)
[07:43:57.238] Timer tick, asking Buildbucket for the build status
[07:43:57.339] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:57.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:136:0) after 1m0s
[07:44:57.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:136:0)
[07:44:57.357] Timer tick, asking Buildbucket for the build status
[07:44:57.454] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:57.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:137:0) after 1m0s
[07:45:57.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:137:0)
[07:45:57.492] Timer tick, asking Buildbucket for the build status
[07:45:57.666] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:57.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:138:0) after 1m0s
[07:46:57.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:138:0)
[07:46:57.728] Timer tick, asking Buildbucket for the build status
[07:46:57.816] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:57.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:139:0) after 1m0s
[07:47:57.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:139:0)
[07:47:57.857] Timer tick, asking Buildbucket for the build status
[07:47:57.922] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:57.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:140:0) after 1m0s
[07:48:58.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:140:0)
[07:48:58.023] Timer tick, asking Buildbucket for the build status
[07:48:58.096] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:58.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:141:0) after 1m0s
[07:49:58.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:141:0)
[07:49:58.186] Timer tick, asking Buildbucket for the build status
[07:49:58.318] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:58.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:142:0) after 1m0s
[07:50:58.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:142:0)
[07:50:58.342] Timer tick, asking Buildbucket for the build status
[07:50:58.509] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:58.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:143:0) after 1m0s
[07:51:58.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:143:0)
[07:51:58.540] Timer tick, asking Buildbucket for the build status
[07:51:58.634] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:58.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:144:0) after 1m0s
[07:52:58.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:144:0)
[07:52:58.740] Timer tick, asking Buildbucket for the build status
[07:52:58.827] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:58.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:145:0) after 1m0s
[07:53:59.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:145:0)
[07:53:59.312] Timer tick, asking Buildbucket for the build status
[07:53:59.394] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:59.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:146:0) after 1m0s
[07:54:59.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:146:0)
[07:54:59.466] Timer tick, asking Buildbucket for the build status
[07:54:59.564] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:59.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:147:0) after 1m0s
[07:55:59.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:147:0)
[07:55:59.819] Timer tick, asking Buildbucket for the build status
[07:55:59.947] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:59.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:148:0) after 1m0s
[07:56:59.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:148:0)
[07:56:59.974] Timer tick, asking Buildbucket for the build status
[07:57:00.224] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:00.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:149:0) after 1m0s
[07:58:00.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:149:0)
[07:58:00.356] Timer tick, asking Buildbucket for the build status
[07:58:00.624] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:00.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:150:0) after 1m0s
[07:59:01.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:150:0)
[07:59:01.055] Timer tick, asking Buildbucket for the build status
[07:59:01.320] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:01.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:151:0) after 1m0s
[08:00:01.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:151:0)
[08:00:01.526] Timer tick, asking Buildbucket for the build status
[08:00:01.735] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:01.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:152:0) after 1m0s
[08:01:02.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:152:0)
[08:01:02.472] Timer tick, asking Buildbucket for the build status
[08:01:02.708] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:02.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:153:0) after 1m0s
[08:02:02.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:153:0)
[08:02:02.783] Timer tick, asking Buildbucket for the build status
[08:02:02.978] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:02.978] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:154:0) after 1m0s
[08:03:03.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:154:0)
[08:03:03.559] Timer tick, asking Buildbucket for the build status
[08:03:03.655] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:03.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:155:0) after 1m0s
[08:04:04.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:155:0)
[08:04:04.602] Timer tick, asking Buildbucket for the build status
[08:04:07.365] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:07.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:156:0) after 1m0s
[08:05:07.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:156:0)
[08:05:07.893] Timer tick, asking Buildbucket for the build status
[08:05:08.146] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:08.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:157:0) after 1m0s
[08:06:08.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:157:0)
[08:06:08.216] Timer tick, asking Buildbucket for the build status
[08:06:08.437] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:08.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:158:0) after 1m0s
[08:07:08.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:158:0)
[08:07:08.467] Timer tick, asking Buildbucket for the build status
[08:07:08.561] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:08.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:159:0) after 1m0s
[08:08:08.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:159:0)
[08:08:08.624] Timer tick, asking Buildbucket for the build status
[08:08:08.725] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:08.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:160:0) after 1m0s
[08:09:08.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:160:0)
[08:09:08.935] Timer tick, asking Buildbucket for the build status
[08:09:09.084] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:09.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:161:0) after 1m0s
[08:10:09.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:161:0)
[08:10:09.206] Timer tick, asking Buildbucket for the build status
[08:10:11.263] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:11.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:162:0) after 1m0s
[08:11:11.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:162:0)
[08:11:11.380] Timer tick, asking Buildbucket for the build status
[08:11:11.513] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:11.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:163:0) after 1m0s
[08:12:11.598] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:163:0)
[08:12:11.598] Timer tick, asking Buildbucket for the build status
[08:12:12.075] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:12.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:164:0) after 1m0s
[08:13:12.160] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:164:0)
[08:13:12.160] Timer tick, asking Buildbucket for the build status
[08:13:12.373] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:12.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:165:0) after 1m0s
[08:14:12.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:165:0)
[08:14:12.452] Timer tick, asking Buildbucket for the build status
[08:14:12.550] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:12.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:166:0) after 1m0s
[08:15:12.611] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:166:0)
[08:15:12.611] Timer tick, asking Buildbucket for the build status
[08:15:13.127] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:13.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:167:0) after 1m0s
[08:16:13.112] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:167:0)
[08:16:13.112] Timer tick, asking Buildbucket for the build status
[08:16:13.991] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:13.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:168:0) after 1m0s
[08:17:14.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:168:0)
[08:17:14.026] Timer tick, asking Buildbucket for the build status
[08:17:14.112] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:14.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:169:0) after 1m0s
[08:18:14.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:169:0)
[08:18:14.182] Timer tick, asking Buildbucket for the build status
[08:18:14.243] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:14.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:170:0) after 1m0s
[08:19:14.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:170:0)
[08:19:14.249] Timer tick, asking Buildbucket for the build status
[08:19:14.303] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:14.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:171:0) after 1m0s
[08:20:14.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:171:0)
[08:20:14.358] Timer tick, asking Buildbucket for the build status
[08:20:14.540] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:14.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:172:0) after 1m0s
[08:21:14.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:172:0)
[08:21:14.632] Timer tick, asking Buildbucket for the build status
[08:21:14.727] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:14.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:173:0) after 1m0s
[08:22:14.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:173:0)
[08:22:14.806] Timer tick, asking Buildbucket for the build status
[08:22:19.355] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:19.355] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:174:0) after 1m0s
[08:23:19.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:174:0)
[08:23:19.401] Timer tick, asking Buildbucket for the build status
[08:23:19.770] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:19.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:175:0) after 1m0s
[08:24:19.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:175:0)
[08:24:19.818] Timer tick, asking Buildbucket for the build status
[08:24:19.918] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:19.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:176:0) after 1m0s
[08:25:19.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:176:0)
[08:25:19.957] Timer tick, asking Buildbucket for the build status
[08:25:20.137] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:20.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:177:0) after 1m0s
[08:26:20.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:177:0)
[08:26:20.189] Timer tick, asking Buildbucket for the build status
[08:26:20.346] Build 8873375202490276448: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:20.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9038805264654724208:178:0) after 1m0s
[08:27:19.714] Received PubSub notification, asking Buildbucket for the build status
[08:27:19.769] Build 8873375202490276448: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:27:19.769] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary": true,
    "canary_preference": "CANARY",
    "completed_ts": "1596097638692287",
    "created_by": "project:infra",
    "created_ts": "1596086991756514",
    "id": "8873375202490276448",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.48\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"480e9f5e-0f9f-473f-9350-d669c3900438\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.48\"}}",
    "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-o8c1\"], \"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": "1596087051135335",
    "status": "COMPLETED",
    "status_changed_ts": "1596097639441726",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9038805264654724208",
      "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/8873375202490276448/+/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:4db70447adb74a10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1596097639455137",
    "url": "https://ci.chromium.org/b/8873375202490276448",
    "utcnow_ts": "1596097639761800"
  }
}
[08:27:19.770] Invocation finished in 2h57m29.461039734s with status SUCCEEDED