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

• parent_buildername:publish_tarball
• user_agent:recipe

[05:29:59.763] New invocation is queued and will start shortly
[05:29:59.763] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[05:30:00.974] Starting the invocation (attempt 1)
[05:30:01.015] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:30:01.015] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:30:01.015] Buildbucket request:
{
  "bucket": "luci.infra.cron",
  "client_operation_id": "9030198542950837504",
  "parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4312.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"ef4e4b7e-2a0f-447e-bf4b-e121ccda64e4\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4312.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:9030198542950837504",
    "scheduler_job_id:infra/Build From Tarball",
    "user_agent:luci-scheduler",
    "parent_buildername:publish_tarball",
    "user_agent:recipe"
  ]
}
[05:30:01.564] Buildbucket response:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "created_by": "project:infra",
    "created_ts": "1604295001131265",
    "id": "8864768480852343696",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4312.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ef4e4b7e-2a0f-447e-bf4b-e121ccda64e4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4312.0\"}}",
    "project": "infra",
    "result_details_json": "{\"properties\": {}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "status": "SCHEDULED",
    "status_changed_ts": "1604295001382092",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9030198542950837504",
      "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/8864768480852343696/+/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": "1604295001382327",
    "url": "https://ci.chromium.org/b/8864768480852343696",
    "utcnow_ts": "1604295001551633"
  }
}
[05:30:01.564] Task URL: https://ci.chromium.org/b/8864768480852343696
[05:30:01.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:2:0) after 1m0s
[05:30:20.182] Received PubSub notification, asking Buildbucket for the build status
[05:30:20.386] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:03.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:2:0)
[05:31:03.131] Timer tick, asking Buildbucket for the build status
[05:31:03.269] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:03.269] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:4:0) after 1m0s
[05:32:03.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:4:0)
[05:32:03.960] Timer tick, asking Buildbucket for the build status
[05:32:04.096] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:04.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:5:0) after 1m0s
[05:33:04.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:5:0)
[05:33:04.167] Timer tick, asking Buildbucket for the build status
[05:33:04.292] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:04.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:6:0) after 1m0s
[05:34:04.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:6:0)
[05:34:04.344] Timer tick, asking Buildbucket for the build status
[05:34:04.420] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:04.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:7:0) after 1m0s
[05:35:04.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:7:0)
[05:35:04.554] Timer tick, asking Buildbucket for the build status
[05:35:04.674] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:04.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:8:0) after 1m0s
[05:36:04.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:8:0)
[05:36:04.802] Timer tick, asking Buildbucket for the build status
[05:36:04.878] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:04.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:9:0) after 1m0s
[05:37:04.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:9:0)
[05:37:04.902] Timer tick, asking Buildbucket for the build status
[05:37:04.978] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:04.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:10:0) after 1m0s
[05:38:05.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:10:0)
[05:38:05.016] Timer tick, asking Buildbucket for the build status
[05:38:05.091] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:05.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:11:0) after 1m0s
[05:39:05.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:11:0)
[05:39:05.105] Timer tick, asking Buildbucket for the build status
[05:39:05.402] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:05.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:12:0) after 1m0s
[05:40:05.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:12:0)
[05:40:05.477] Timer tick, asking Buildbucket for the build status
[05:40:05.591] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:05.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:13:0) after 1m0s
[05:41:06.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:13:0)
[05:41:06.199] Timer tick, asking Buildbucket for the build status
[05:41:06.298] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:06.298] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:14:0) after 1m0s
[05:42:06.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:14:0)
[05:42:06.409] Timer tick, asking Buildbucket for the build status
[05:42:06.571] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:06.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:15:0) after 1m0s
[05:43:06.613] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:15:0)
[05:43:06.613] Timer tick, asking Buildbucket for the build status
[05:43:06.683] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:06.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:16:0) after 1m0s
[05:44:06.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:16:0)
[05:44:06.737] Timer tick, asking Buildbucket for the build status
[05:44:06.812] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:06.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:17:0) after 1m0s
[05:45:06.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:17:0)
[05:45:06.861] Timer tick, asking Buildbucket for the build status
[05:45:07.012] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:07.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:18:0) after 1m0s
[05:46:07.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:18:0)
[05:46:07.040] Timer tick, asking Buildbucket for the build status
[05:46:07.126] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:07.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:19:0) after 1m0s
[05:47:07.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:19:0)
[05:47:07.151] Timer tick, asking Buildbucket for the build status
[05:47:07.211] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:07.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:20:0) after 1m0s
[05:48:07.255] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:20:0)
[05:48:07.255] Timer tick, asking Buildbucket for the build status
[05:48:07.337] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:07.337] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:21:0) after 1m0s
[05:49:07.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:21:0)
[05:49:07.399] Timer tick, asking Buildbucket for the build status
[05:49:07.570] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:07.570] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:22:0) after 1m0s
[05:50:08.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:22:0)
[05:50:08.233] Timer tick, asking Buildbucket for the build status
[05:50:08.350] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:08.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:23:0) after 1m0s
[05:51:08.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:23:0)
[05:51:08.879] Timer tick, asking Buildbucket for the build status
[05:51:08.941] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:08.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:24:0) after 1m0s
[05:52:09.124] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:24:0)
[05:52:09.124] Timer tick, asking Buildbucket for the build status
[05:52:09.252] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:09.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:25:0) after 1m0s
[05:53:09.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:25:0)
[05:53:09.293] Timer tick, asking Buildbucket for the build status
[05:53:09.359] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:09.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:26:0) after 1m0s
[05:54:09.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:26:0)
[05:54:09.620] Timer tick, asking Buildbucket for the build status
[05:54:09.816] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:09.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:27:0) after 1m0s
[05:55:09.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:27:0)
[05:55:09.906] Timer tick, asking Buildbucket for the build status
[05:55:10.095] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:10.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:28:0) after 1m0s
[05:56:10.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:28:0)
[05:56:10.158] Timer tick, asking Buildbucket for the build status
[05:56:10.241] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:10.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:29:0) after 1m0s
[05:57:10.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:29:0)
[05:57:10.305] Timer tick, asking Buildbucket for the build status
[05:57:10.365] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:10.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:30:0) after 1m0s
[05:58:10.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:30:0)
[05:58:10.534] Timer tick, asking Buildbucket for the build status
[05:58:10.698] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:10.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:31:0) after 1m0s
[05:59:10.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:31:0)
[05:59:10.751] Timer tick, asking Buildbucket for the build status
[05:59:10.819] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:10.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:32:0) after 1m0s
[06:00:10.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:32:0)
[06:00:10.895] Timer tick, asking Buildbucket for the build status
[06:00:11.164] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:11.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:33:0) after 1m0s
[06:01:18.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:33:0)
[06:01:18.854] Timer tick, asking Buildbucket for the build status
[06:01:18.916] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:18.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:34:0) after 1m0s
[06:02:18.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:34:0)
[06:02:18.977] Timer tick, asking Buildbucket for the build status
[06:02:19.052] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:19.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:35:0) after 1m0s
[06:03:19.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:35:0)
[06:03:19.115] Timer tick, asking Buildbucket for the build status
[06:03:19.231] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:19.232] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:36:0) after 1m0s
[06:04:19.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:36:0)
[06:04:19.352] Timer tick, asking Buildbucket for the build status
[06:04:19.532] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:19.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:37:0) after 1m0s
[06:05:19.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:37:0)
[06:05:19.546] Timer tick, asking Buildbucket for the build status
[06:05:19.643] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:19.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:38:0) after 1m0s
[06:06:19.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:38:0)
[06:06:19.811] Timer tick, asking Buildbucket for the build status
[06:06:19.920] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:19.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:39:0) after 1m0s
[06:07:20.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:39:0)
[06:07:20.051] Timer tick, asking Buildbucket for the build status
[06:07:20.135] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:20.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:40:0) after 1m0s
[06:08:20.200] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:40:0)
[06:08:20.200] Timer tick, asking Buildbucket for the build status
[06:08:20.260] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:20.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:41:0) after 1m0s
[06:09:20.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:41:0)
[06:09:20.342] Timer tick, asking Buildbucket for the build status
[06:09:20.403] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:20.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:42:0) after 1m0s
[06:10:20.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:42:0)
[06:10:20.535] Timer tick, asking Buildbucket for the build status
[06:10:20.651] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:20.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:43:0) after 1m0s
[06:11:20.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:43:0)
[06:11:20.750] Timer tick, asking Buildbucket for the build status
[06:11:20.876] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:20.876] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:44:0) after 1m0s
[06:12:20.976] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:44:0)
[06:12:20.976] Timer tick, asking Buildbucket for the build status
[06:12:21.105] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:21.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:45:0) after 1m0s
[06:13:21.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:45:0)
[06:13:21.370] Timer tick, asking Buildbucket for the build status
[06:13:21.436] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:21.436] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:46:0) after 1m0s
[06:14:21.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:46:0)
[06:14:21.577] Timer tick, asking Buildbucket for the build status
[06:14:21.638] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:21.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:47:0) after 1m0s
[06:15:21.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:47:0)
[06:15:21.685] Timer tick, asking Buildbucket for the build status
[06:15:21.787] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:21.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:48:0) after 1m0s
[06:16:21.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:48:0)
[06:16:21.867] Timer tick, asking Buildbucket for the build status
[06:16:21.931] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:21.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:49:0) after 1m0s
[06:17:21.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:49:0)
[06:17:21.987] Timer tick, asking Buildbucket for the build status
[06:17:22.059] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:22.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:50:0) after 1m0s
[06:18:22.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:50:0)
[06:18:22.126] Timer tick, asking Buildbucket for the build status
[06:18:22.503] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:22.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:51:0) after 1m0s
[06:19:22.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:51:0)
[06:19:22.557] Timer tick, asking Buildbucket for the build status
[06:19:22.652] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:22.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:52:0) after 1m0s
[06:20:22.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:52:0)
[06:20:22.716] Timer tick, asking Buildbucket for the build status
[06:20:23.074] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:23.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:53:0) after 1m0s
[06:21:23.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:53:0)
[06:21:23.102] Timer tick, asking Buildbucket for the build status
[06:21:23.439] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:23.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:54:0) after 1m0s
[06:22:23.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:54:0)
[06:22:23.461] Timer tick, asking Buildbucket for the build status
[06:22:23.579] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:23.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:55:0) after 1m0s
[06:23:23.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:55:0)
[06:23:23.588] Timer tick, asking Buildbucket for the build status
[06:23:23.765] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:23.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:56:0) after 1m0s
[06:24:23.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:56:0)
[06:24:23.825] Timer tick, asking Buildbucket for the build status
[06:24:23.883] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:23.883] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:57:0) after 1m0s
[06:25:23.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:57:0)
[06:25:23.938] Timer tick, asking Buildbucket for the build status
[06:25:24.038] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:24.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:58:0) after 1m0s
[06:26:24.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:58:0)
[06:26:24.098] Timer tick, asking Buildbucket for the build status
[06:26:24.155] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:24.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:59:0) after 1m0s
[06:27:24.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:59:0)
[06:27:24.151] Timer tick, asking Buildbucket for the build status
[06:27:24.472] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:24.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:60:0) after 1m0s
[06:28:24.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:60:0)
[06:28:24.467] Timer tick, asking Buildbucket for the build status
[06:28:24.785] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:24.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:61:0) after 1m0s
[06:29:24.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:61:0)
[06:29:24.847] Timer tick, asking Buildbucket for the build status
[06:29:25.003] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:25.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:62:0) after 1m0s
[06:30:25.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:62:0)
[06:30:25.059] Timer tick, asking Buildbucket for the build status
[06:30:25.276] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:25.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:63:0) after 1m0s
[06:31:25.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:63:0)
[06:31:25.291] Timer tick, asking Buildbucket for the build status
[06:31:25.442] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:25.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:64:0) after 1m0s
[06:32:25.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:64:0)
[06:32:25.464] Timer tick, asking Buildbucket for the build status
[06:32:25.584] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:25.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:65:0) after 1m0s
[06:33:25.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:65:0)
[06:33:25.661] Timer tick, asking Buildbucket for the build status
[06:33:25.727] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:25.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:66:0) after 1m0s
[06:34:26.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:66:0)
[06:34:26.391] Timer tick, asking Buildbucket for the build status
[06:34:26.548] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:26.548] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:67:0) after 1m0s
[06:35:26.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:67:0)
[06:35:26.825] Timer tick, asking Buildbucket for the build status
[06:35:27.283] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:27.283] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:68:0) after 1m0s
[06:36:27.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:68:0)
[06:36:27.428] Timer tick, asking Buildbucket for the build status
[06:36:27.551] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:27.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:69:0) after 1m0s
[06:37:27.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:69:0)
[06:37:27.664] Timer tick, asking Buildbucket for the build status
[06:37:27.730] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:27.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:70:0) after 1m0s
[06:38:27.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:70:0)
[06:38:27.754] Timer tick, asking Buildbucket for the build status
[06:38:28.208] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:28.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:71:0) after 1m0s
[06:39:28.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:71:0)
[06:39:28.336] Timer tick, asking Buildbucket for the build status
[06:39:28.926] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:28.926] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:72:0) after 1m0s
[06:40:29.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:72:0)
[06:40:29.102] Timer tick, asking Buildbucket for the build status
[06:40:29.243] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:29.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:73:0) after 1m0s
[06:41:29.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:73:0)
[06:41:29.270] Timer tick, asking Buildbucket for the build status
[06:41:29.361] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:29.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:74:0) after 1m0s
[06:42:29.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:74:0)
[06:42:29.490] Timer tick, asking Buildbucket for the build status
[06:42:30.379] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:30.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:75:0) after 1m0s
[06:43:30.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:75:0)
[06:43:30.589] Timer tick, asking Buildbucket for the build status
[06:43:30.662] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:30.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:76:0) after 1m0s
[06:44:30.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:76:0)
[06:44:30.859] Timer tick, asking Buildbucket for the build status
[06:44:30.918] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:30.918] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:77:0) after 1m0s
[06:45:30.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:77:0)
[06:45:30.987] Timer tick, asking Buildbucket for the build status
[06:45:31.319] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:31.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:78:0) after 1m0s
[06:46:31.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:78:0)
[06:46:31.359] Timer tick, asking Buildbucket for the build status
[06:46:31.865] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:31.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:79:0) after 1m0s
[06:47:31.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:79:0)
[06:47:31.990] Timer tick, asking Buildbucket for the build status
[06:47:32.105] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:32.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:80:0) after 1m0s
[06:48:32.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:80:0)
[06:48:32.204] Timer tick, asking Buildbucket for the build status
[06:48:32.288] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:32.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:81:0) after 1m0s
[06:49:32.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:81:0)
[06:49:32.291] Timer tick, asking Buildbucket for the build status
[06:49:32.350] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:32.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:82:0) after 1m0s
[06:50:32.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:82:0)
[06:50:32.379] Timer tick, asking Buildbucket for the build status
[06:50:32.492] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:32.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:83:0) after 1m0s
[06:51:32.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:83:0)
[06:51:32.516] Timer tick, asking Buildbucket for the build status
[06:51:32.583] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:32.583] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:84:0) after 1m0s
[06:52:32.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:84:0)
[06:52:32.662] Timer tick, asking Buildbucket for the build status
[06:52:33.671] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:33.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:85:0) after 1m0s
[06:53:33.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:85:0)
[06:53:33.745] Timer tick, asking Buildbucket for the build status
[06:53:33.797] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:33.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:86:0) after 1m0s
[06:54:33.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:86:0)
[06:54:33.834] Timer tick, asking Buildbucket for the build status
[06:54:33.893] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:33.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:87:0) after 1m0s
[06:55:33.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:87:0)
[06:55:33.882] Timer tick, asking Buildbucket for the build status
[06:55:34.009] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:34.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:88:0) after 1m0s
[06:56:34.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:88:0)
[06:56:34.093] Timer tick, asking Buildbucket for the build status
[06:56:34.152] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:34.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:89:0) after 1m0s
[06:57:34.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:89:0)
[06:57:34.177] Timer tick, asking Buildbucket for the build status
[06:57:34.369] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:34.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:90:0) after 1m0s
[06:58:34.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:90:0)
[06:58:34.402] Timer tick, asking Buildbucket for the build status
[06:58:34.495] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:34.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:91:0) after 1m0s
[06:59:34.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:91:0)
[06:59:34.521] Timer tick, asking Buildbucket for the build status
[06:59:34.632] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:34.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:92:0) after 1m0s
[07:00:34.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:92:0)
[07:00:34.672] Timer tick, asking Buildbucket for the build status
[07:00:34.800] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:34.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:93:0) after 1m0s
[07:01:34.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:93:0)
[07:01:34.862] Timer tick, asking Buildbucket for the build status
[07:01:34.932] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:34.932] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:94:0) after 1m0s
[07:02:34.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:94:0)
[07:02:34.971] Timer tick, asking Buildbucket for the build status
[07:02:35.872] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:35.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:95:0) after 1m0s
[07:03:36.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:95:0)
[07:03:36.040] Timer tick, asking Buildbucket for the build status
[07:03:36.118] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:36.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:96:0) after 1m0s
[07:04:36.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:96:0)
[07:04:36.333] Timer tick, asking Buildbucket for the build status
[07:04:36.397] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:36.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:97:0) after 1m0s
[07:05:36.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:97:0)
[07:05:36.501] Timer tick, asking Buildbucket for the build status
[07:05:36.618] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:36.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:98:0) after 1m0s
[07:06:36.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:98:0)
[07:06:36.711] Timer tick, asking Buildbucket for the build status
[07:06:36.793] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:36.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:99:0) after 1m0s
[07:07:36.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:99:0)
[07:07:36.923] Timer tick, asking Buildbucket for the build status
[07:07:39.313] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:39.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:100:0) after 1m0s
[07:08:39.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:100:0)
[07:08:39.480] Timer tick, asking Buildbucket for the build status
[07:08:39.540] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:39.540] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:101:0) after 1m0s
[07:09:39.612] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:101:0)
[07:09:39.613] Timer tick, asking Buildbucket for the build status
[07:09:39.679] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:39.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:102:0) after 1m0s
[07:10:39.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:102:0)
[07:10:39.769] Timer tick, asking Buildbucket for the build status
[07:10:39.984] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:39.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:103:0) after 1m0s
[07:11:40.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:103:0)
[07:11:40.014] Timer tick, asking Buildbucket for the build status
[07:11:40.086] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:40.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:104:0) after 1m0s
[07:12:40.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:104:0)
[07:12:40.156] Timer tick, asking Buildbucket for the build status
[07:12:40.289] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:40.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:105:0) after 1m0s
[07:13:40.426] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:105:0)
[07:13:40.426] Timer tick, asking Buildbucket for the build status
[07:13:40.505] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:40.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:106:0) after 1m0s
[07:14:40.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:106:0)
[07:14:40.535] Timer tick, asking Buildbucket for the build status
[07:14:40.595] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:40.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:107:0) after 1m0s
[07:15:40.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:107:0)
[07:15:40.695] Timer tick, asking Buildbucket for the build status
[07:15:40.971] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:40.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:108:0) after 1m0s
[07:16:41.094] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:108:0)
[07:16:41.094] Timer tick, asking Buildbucket for the build status
[07:16:41.234] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:41.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:109:0) after 1m0s
[07:17:41.240] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:109:0)
[07:17:41.240] Timer tick, asking Buildbucket for the build status
[07:17:41.451] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:41.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:110:0) after 1m0s
[07:18:41.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:110:0)
[07:18:41.643] Timer tick, asking Buildbucket for the build status
[07:18:41.743] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:41.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:111:0) after 1m0s
[07:19:41.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:111:0)
[07:19:41.769] Timer tick, asking Buildbucket for the build status
[07:19:41.867] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:41.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:112:0) after 1m0s
[07:20:41.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:112:0)
[07:20:41.892] Timer tick, asking Buildbucket for the build status
[07:20:42.003] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:42.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:113:0) after 1m0s
[07:21:42.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:113:0)
[07:21:42.086] Timer tick, asking Buildbucket for the build status
[07:21:42.147] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:42.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:114:0) after 1m0s
[07:22:42.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:114:0)
[07:22:42.223] Timer tick, asking Buildbucket for the build status
[07:22:42.896] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:42.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:115:0) after 1m0s
[07:23:43.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:115:0)
[07:23:43.064] Timer tick, asking Buildbucket for the build status
[07:23:43.249] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:43.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:116:0) after 1m0s
[07:24:43.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:116:0)
[07:24:43.386] Timer tick, asking Buildbucket for the build status
[07:24:43.454] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:43.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:117:0) after 1m0s
[07:25:43.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:117:0)
[07:25:43.513] Timer tick, asking Buildbucket for the build status
[07:25:43.616] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:43.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:118:0) after 1m0s
[07:26:43.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:118:0)
[07:26:43.648] Timer tick, asking Buildbucket for the build status
[07:26:43.854] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:43.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:119:0) after 1m0s
[07:27:43.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:119:0)
[07:27:43.883] Timer tick, asking Buildbucket for the build status
[07:27:43.993] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:43.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:120:0) after 1m0s
[07:28:44.017] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:120:0)
[07:28:44.017] Timer tick, asking Buildbucket for the build status
[07:28:44.163] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:44.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:121:0) after 1m0s
[07:29:44.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:121:0)
[07:29:44.256] Timer tick, asking Buildbucket for the build status
[07:29:44.341] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:44.341] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:122:0) after 1m0s
[07:30:44.368] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:122:0)
[07:30:44.368] Timer tick, asking Buildbucket for the build status
[07:30:45.479] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:45.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:123:0) after 1m0s
[07:31:45.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:123:0)
[07:31:45.558] Timer tick, asking Buildbucket for the build status
[07:31:45.670] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:45.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:124:0) after 1m0s
[07:32:45.745] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:124:0)
[07:32:45.745] Timer tick, asking Buildbucket for the build status
[07:32:45.810] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:45.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:125:0) after 1m0s
[07:33:45.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:125:0)
[07:33:45.986] Timer tick, asking Buildbucket for the build status
[07:33:46.048] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:46.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:126:0) after 1m0s
[07:34:46.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:126:0)
[07:34:46.272] Timer tick, asking Buildbucket for the build status
[07:34:46.350] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:46.350] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:127:0) after 1m0s
[07:35:46.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:127:0)
[07:35:46.490] Timer tick, asking Buildbucket for the build status
[07:35:46.854] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:46.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:128:0) after 1m0s
[07:36:47.036] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:128:0)
[07:36:47.036] Timer tick, asking Buildbucket for the build status
[07:36:47.176] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:47.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:129:0) after 1m0s
[07:37:47.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:129:0)
[07:37:47.214] Timer tick, asking Buildbucket for the build status
[07:37:47.748] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:47.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:130:0) after 1m0s
[07:38:47.847] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:130:0)
[07:38:47.847] Timer tick, asking Buildbucket for the build status
[07:38:47.910] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:47.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:131:0) after 1m0s
[07:39:47.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:131:0)
[07:39:47.996] Timer tick, asking Buildbucket for the build status
[07:39:48.057] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:48.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:132:0) after 1m0s
[07:40:48.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:132:0)
[07:40:48.115] Timer tick, asking Buildbucket for the build status
[07:40:48.295] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:48.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:133:0) after 1m0s
[07:41:48.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:133:0)
[07:41:48.421] Timer tick, asking Buildbucket for the build status
[07:41:48.499] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:48.499] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:134:0) after 1m0s
[07:42:48.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:134:0)
[07:42:48.530] Timer tick, asking Buildbucket for the build status
[07:42:48.695] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:48.695] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:135:0) after 1m0s
[07:43:48.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:135:0)
[07:43:48.769] Timer tick, asking Buildbucket for the build status
[07:43:48.966] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:48.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:136:0) after 1m0s
[07:44:49.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:136:0)
[07:44:49.051] Timer tick, asking Buildbucket for the build status
[07:44:49.132] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:49.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:137:0) after 1m0s
[07:45:49.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:137:0)
[07:45:49.173] Timer tick, asking Buildbucket for the build status
[07:45:49.306] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:49.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:138:0) after 1m0s
[07:46:49.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:138:0)
[07:46:49.338] Timer tick, asking Buildbucket for the build status
[07:46:49.845] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:49.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:139:0) after 1m0s
[07:47:49.969] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:139:0)
[07:47:49.969] Timer tick, asking Buildbucket for the build status
[07:47:50.037] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:50.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:140:0) after 1m0s
[07:48:50.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:140:0)
[07:48:50.092] Timer tick, asking Buildbucket for the build status
[07:48:51.163] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:51.163] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:141:0) after 1m0s
[07:49:51.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:141:0)
[07:49:51.347] Timer tick, asking Buildbucket for the build status
[07:49:51.437] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:51.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:142:0) after 1m0s
[07:50:51.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:142:0)
[07:50:51.493] Timer tick, asking Buildbucket for the build status
[07:50:51.633] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:51.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:143:0) after 1m0s
[07:51:51.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:143:0)
[07:51:51.669] Timer tick, asking Buildbucket for the build status
[07:51:51.734] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:51.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:144:0) after 1m0s
[07:52:51.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:144:0)
[07:52:51.874] Timer tick, asking Buildbucket for the build status
[07:52:51.933] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:51.933] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:145:0) after 1m0s
[07:53:51.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:145:0)
[07:53:51.983] Timer tick, asking Buildbucket for the build status
[07:53:52.227] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:52.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:146:0) after 1m0s
[07:54:52.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:146:0)
[07:54:52.304] Timer tick, asking Buildbucket for the build status
[07:54:52.486] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:52.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:147:0) after 1m0s
[07:55:52.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:147:0)
[07:55:52.580] Timer tick, asking Buildbucket for the build status
[07:55:52.853] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:52.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:148:0) after 1m0s
[07:56:52.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:148:0)
[07:56:52.937] Timer tick, asking Buildbucket for the build status
[07:56:53.007] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:53.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:149:0) after 1m0s
[07:57:53.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:149:0)
[07:57:53.069] Timer tick, asking Buildbucket for the build status
[07:57:53.142] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:53.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:150:0) after 1m0s
[07:58:53.204] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:150:0)
[07:58:53.204] Timer tick, asking Buildbucket for the build status
[07:58:53.294] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:53.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:151:0) after 1m0s
[07:59:53.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:151:0)
[07:59:53.323] Timer tick, asking Buildbucket for the build status
[07:59:53.380] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:53.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:152:0) after 1m0s
[08:00:53.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:152:0)
[08:00:53.411] Timer tick, asking Buildbucket for the build status
[08:00:53.632] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:53.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:153:0) after 1m0s
[08:01:53.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:153:0)
[08:01:53.779] Timer tick, asking Buildbucket for the build status
[08:01:53.868] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:53.868] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:154:0) after 1m0s
[08:02:53.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:154:0)
[08:02:53.932] Timer tick, asking Buildbucket for the build status
[08:02:54.009] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:54.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:155:0) after 1m0s
[08:03:54.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:155:0)
[08:03:54.290] Timer tick, asking Buildbucket for the build status
[08:03:54.383] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:54.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:156:0) after 1m0s
[08:04:54.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:156:0)
[08:04:54.490] Timer tick, asking Buildbucket for the build status
[08:04:54.572] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:54.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:157:0) after 1m0s
[08:05:54.619] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:157:0)
[08:05:54.619] Timer tick, asking Buildbucket for the build status
[08:05:54.850] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:54.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:158:0) after 1m0s
[08:06:54.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:158:0)
[08:06:54.977] Timer tick, asking Buildbucket for the build status
[08:06:55.088] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:55.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:159:0) after 1m0s
[08:07:55.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:159:0)
[08:07:55.214] Timer tick, asking Buildbucket for the build status
[08:07:55.276] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:55.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:160:0) after 1m0s
[08:08:55.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:160:0)
[08:08:55.384] Timer tick, asking Buildbucket for the build status
[08:08:55.455] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:55.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:161:0) after 1m0s
[08:09:55.583] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:161:0)
[08:09:55.583] Timer tick, asking Buildbucket for the build status
[08:09:55.661] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:55.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:162:0) after 1m0s
[08:10:55.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:162:0)
[08:10:55.665] Timer tick, asking Buildbucket for the build status
[08:10:55.794] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:55.794] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:163:0) after 1m0s
[08:11:55.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:163:0)
[08:11:55.865] Timer tick, asking Buildbucket for the build status
[08:11:56.126] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:56.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:164:0) after 1m0s
[08:12:56.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:164:0)
[08:12:56.155] Timer tick, asking Buildbucket for the build status
[08:12:56.444] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:56.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:165:0) after 1m0s
[08:13:56.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:165:0)
[08:13:56.590] Timer tick, asking Buildbucket for the build status
[08:13:56.757] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:56.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:166:0) after 1m0s
[08:14:56.857] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:166:0)
[08:14:56.857] Timer tick, asking Buildbucket for the build status
[08:14:56.944] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:56.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:167:0) after 1m0s
[08:15:57.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:167:0)
[08:15:57.052] Timer tick, asking Buildbucket for the build status
[08:15:57.177] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:57.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:168:0) after 1m0s
[08:16:57.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:168:0)
[08:16:57.225] Timer tick, asking Buildbucket for the build status
[08:16:57.321] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:57.321] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:169:0) after 1m0s
[08:17:57.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:169:0)
[08:17:57.350] Timer tick, asking Buildbucket for the build status
[08:17:57.627] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:57.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:170:0) after 1m0s
[08:18:57.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:170:0)
[08:18:57.670] Timer tick, asking Buildbucket for the build status
[08:18:57.745] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:57.745] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:171:0) after 1m0s
[08:19:58.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:171:0)
[08:19:58.213] Timer tick, asking Buildbucket for the build status
[08:19:58.408] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:58.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:172:0) after 1m0s
[08:20:58.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:172:0)
[08:20:58.451] Timer tick, asking Buildbucket for the build status
[08:20:58.796] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:58.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:173:0) after 1m0s
[08:21:59.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:173:0)
[08:21:59.080] Timer tick, asking Buildbucket for the build status
[08:21:59.347] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:59.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:174:0) after 1m0s
[08:22:59.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:174:0)
[08:22:59.394] Timer tick, asking Buildbucket for the build status
[08:22:59.507] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:59.507] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:175:0) after 1m0s
[08:23:59.545] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:175:0)
[08:23:59.545] Timer tick, asking Buildbucket for the build status
[08:23:59.790] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:59.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:176:0) after 1m0s
[08:25:00.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:176:0)
[08:25:00.022] Timer tick, asking Buildbucket for the build status
[08:25:00.533] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:00.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:177:0) after 1m0s
[08:26:01.475] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:177:0)
[08:26:01.475] Timer tick, asking Buildbucket for the build status
[08:26:01.938] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:01.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:178:0) after 1m0s
[08:27:01.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:178:0)
[08:27:01.970] Timer tick, asking Buildbucket for the build status
[08:27:02.299] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:02.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:179:0) after 1m0s
[08:28:02.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:179:0)
[08:28:02.472] Timer tick, asking Buildbucket for the build status
[08:28:02.553] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:02.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:180:0) after 1m0s
[08:29:02.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:180:0)
[08:29:02.688] Timer tick, asking Buildbucket for the build status
[08:29:02.768] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:02.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:181:0) after 1m0s
[08:30:02.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:181:0)
[08:30:02.971] Timer tick, asking Buildbucket for the build status
[08:30:03.057] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:03.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:182:0) after 1m0s
[08:32:18.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:182:0)
[08:32:18.482] Timer tick, asking Buildbucket for the build status
[08:32:18.592] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:18.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:183:0) after 1m0s
[08:33:18.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:183:0)
[08:33:18.677] Timer tick, asking Buildbucket for the build status
[08:33:18.838] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:18.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:184:0) after 1m0s
[08:34:18.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:184:0)
[08:34:18.854] Timer tick, asking Buildbucket for the build status
[08:34:20.486] Build 8864768480852343696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:20.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030198542950837504:185:0) after 1m0s
[08:34:22.071] Received PubSub notification, asking Buildbucket for the build status
[08:34:22.325] Build 8864768480852343696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:34:22.325] Buildbucket build:
{
  "build": {
    "bucket": "luci.infra.cron",
    "canary_preference": "PROD",
    "completed_ts": "1604306060207244",
    "created_by": "project:infra",
    "created_ts": "1604295001131265",
    "id": "8864768480852343696",
    "parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4312.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"ef4e4b7e-2a0f-447e-bf4b-e121ccda64e4\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4312.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-1n23\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
    "service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
    "started_ts": "1604295008866250",
    "status": "COMPLETED",
    "status_changed_ts": "1604306061001819",
    "tags": [
      "builder:Build From Tarball",
      "parent_buildername:publish_tarball",
      "scheduler_invocation_id:9030198542950837504",
      "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/8864768480852343696/+/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:4fa0409058c9ff10",
      "user_agent:luci-scheduler",
      "user_agent:recipe"
    ],
    "updated_ts": "1604306061482240",
    "url": "https://ci.chromium.org/b/8864768480852343696",
    "utcnow_ts": "1604306062297566"
  }
}
[08:34:22.325] Invocation finished in 3h4m22.578880188s with status SUCCEEDED