[05:37:34.141] New invocation is queued and will start shortly
[05:37:34.141] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[05:37:35.363] Starting the invocation (attempt 1)
[05:37:35.399] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:37:35.399] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:37:35.399] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9049767011246614192",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4099.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"3b809007-ddbe-4aa1-8da4-d8cb2690b3ef\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4099.4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9049767011246614192",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[05:37:36.267] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1585633055523813",
"id": "8884336949130401296",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4099.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3b809007-ddbe-4aa1-8da4-d8cb2690b3ef\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4099.4\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585633056019535",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9049767011246614192",
"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/8884336949130401296/+/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": "1585633056020487",
"url": "https://ci.chromium.org/b/8884336949130401296",
"utcnow_ts": "1585633056256661"
}
}
[05:37:36.267] Task URL: https://ci.chromium.org/b/8884336949130401296
[05:37:36.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:2:0) after 1m0s
[05:38:10.150] Received PubSub notification, asking Buildbucket for the build status
[05:38:10.240] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:36.294] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:2:0)
[05:38:36.294] Timer tick, asking Buildbucket for the build status
[05:38:37.423] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:37.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:4:0) after 1m0s
[05:39:37.498] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:4:0)
[05:39:37.498] Timer tick, asking Buildbucket for the build status
[05:39:37.634] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:37.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:5:0) after 1m0s
[05:40:37.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:5:0)
[05:40:37.785] Timer tick, asking Buildbucket for the build status
[05:40:37.897] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:37.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:6:0) after 1m0s
[05:41:38.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:6:0)
[05:41:38.078] Timer tick, asking Buildbucket for the build status
[05:41:38.169] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:38.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:7:0) after 1m0s
[05:42:38.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:7:0)
[05:42:38.214] Timer tick, asking Buildbucket for the build status
[05:42:38.344] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:38.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:8:0) after 1m0s
[05:43:38.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:8:0)
[05:43:38.398] Timer tick, asking Buildbucket for the build status
[05:43:38.715] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:38.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:9:0) after 1m0s
[05:44:38.837] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:9:0)
[05:44:38.837] Timer tick, asking Buildbucket for the build status
[05:44:38.964] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:38.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:10:0) after 1m0s
[05:45:39.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:10:0)
[05:45:39.005] Timer tick, asking Buildbucket for the build status
[05:45:39.187] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:39.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:11:0) after 1m0s
[05:46:39.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:11:0)
[05:46:39.257] Timer tick, asking Buildbucket for the build status
[05:46:39.440] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:39.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:12:0) after 1m0s
[05:47:39.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:12:0)
[05:47:39.541] Timer tick, asking Buildbucket for the build status
[05:47:39.844] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:39.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:13:0) after 1m0s
[05:48:39.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:13:0)
[05:48:39.974] Timer tick, asking Buildbucket for the build status
[05:48:40.419] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:40.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:14:0) after 1m0s
[05:49:40.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:14:0)
[05:49:40.474] Timer tick, asking Buildbucket for the build status
[05:49:40.734] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:40.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:15:0) after 1m0s
[05:50:40.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:15:0)
[05:50:40.808] Timer tick, asking Buildbucket for the build status
[05:50:41.297] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:41.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:16:0) after 1m0s
[05:51:41.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:16:0)
[05:51:41.405] Timer tick, asking Buildbucket for the build status
[05:51:41.642] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:41.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:17:0) after 1m0s
[05:52:41.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:17:0)
[05:52:41.751] Timer tick, asking Buildbucket for the build status
[05:52:42.059] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:42.059] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:18:0) after 1m0s
[05:53:42.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:18:0)
[05:53:42.141] Timer tick, asking Buildbucket for the build status
[05:53:42.467] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:42.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:19:0) after 1m0s
[05:54:42.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:19:0)
[05:54:42.512] Timer tick, asking Buildbucket for the build status
[05:54:42.782] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:42.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:20:0) after 1m0s
[05:55:42.882] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:20:0)
[05:55:42.882] Timer tick, asking Buildbucket for the build status
[05:55:43.102] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:43.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:21:0) after 1m0s
[05:56:43.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:21:0)
[05:56:43.141] Timer tick, asking Buildbucket for the build status
[05:56:43.320] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:43.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:22:0) after 1m0s
[05:57:43.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:22:0)
[05:57:43.384] Timer tick, asking Buildbucket for the build status
[05:57:43.530] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:43.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:23:0) after 1m0s
[05:58:43.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:23:0)
[05:58:43.547] Timer tick, asking Buildbucket for the build status
[05:58:43.786] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:43.786] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:24:0) after 1m0s
[05:59:43.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:24:0)
[05:59:43.811] Timer tick, asking Buildbucket for the build status
[05:59:43.941] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:43.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:25:0) after 1m0s
[06:00:43.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:25:0)
[06:00:43.983] Timer tick, asking Buildbucket for the build status
[06:00:44.187] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:44.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:26:0) after 1m0s
[06:01:44.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:26:0)
[06:01:44.236] Timer tick, asking Buildbucket for the build status
[06:01:44.402] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:44.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:27:0) after 1m0s
[06:02:44.458] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:27:0)
[06:02:44.458] Timer tick, asking Buildbucket for the build status
[06:02:45.007] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:45.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:28:0) after 1m0s
[06:03:45.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:28:0)
[06:03:45.035] Timer tick, asking Buildbucket for the build status
[06:03:45.240] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:45.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:29:0) after 1m0s
[06:04:45.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:29:0)
[06:04:45.244] Timer tick, asking Buildbucket for the build status
[06:04:45.678] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:45.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:30:0) after 1m0s
[06:05:45.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:30:0)
[06:05:45.709] Timer tick, asking Buildbucket for the build status
[06:05:45.992] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:45.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:31:0) after 1m0s
[06:06:46.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:31:0)
[06:06:46.011] Timer tick, asking Buildbucket for the build status
[06:06:46.229] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:46.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:32:0) after 1m0s
[06:07:46.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:32:0)
[06:07:46.386] Timer tick, asking Buildbucket for the build status
[06:07:46.829] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:46.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:33:0) after 1m0s
[06:08:46.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:33:0)
[06:08:46.850] Timer tick, asking Buildbucket for the build status
[06:08:46.956] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:46.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:34:0) after 1m0s
[06:09:46.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:34:0)
[06:09:46.983] Timer tick, asking Buildbucket for the build status
[06:09:47.115] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:47.115] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:35:0) after 1m0s
[06:10:47.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:35:0)
[06:10:47.254] Timer tick, asking Buildbucket for the build status
[06:10:47.472] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:47.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:36:0) after 1m0s
[06:11:47.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:36:0)
[06:11:47.506] Timer tick, asking Buildbucket for the build status
[06:11:47.754] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:47.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:37:0) after 1m0s
[06:12:47.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:37:0)
[06:12:47.824] Timer tick, asking Buildbucket for the build status
[06:12:48.243] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:48.243] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:38:0) after 1m0s
[06:13:48.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:38:0)
[06:13:48.261] Timer tick, asking Buildbucket for the build status
[06:13:48.503] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:48.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:39:0) after 1m0s
[06:14:48.524] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:39:0)
[06:14:48.524] Timer tick, asking Buildbucket for the build status
[06:14:48.804] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:48.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:40:0) after 1m0s
[06:15:48.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:40:0)
[06:15:48.841] Timer tick, asking Buildbucket for the build status
[06:15:49.118] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:49.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:41:0) after 1m0s
[06:16:49.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:41:0)
[06:16:49.156] Timer tick, asking Buildbucket for the build status
[06:16:49.373] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:49.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:42:0) after 1m0s
[06:17:49.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:42:0)
[06:17:49.449] Timer tick, asking Buildbucket for the build status
[06:17:49.631] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:49.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:43:0) after 1m0s
[06:18:49.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:43:0)
[06:18:49.696] Timer tick, asking Buildbucket for the build status
[06:18:49.903] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:49.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:44:0) after 1m0s
[06:19:50.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:44:0)
[06:19:50.029] Timer tick, asking Buildbucket for the build status
[06:19:50.498] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:50.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:45:0) after 1m0s
[06:20:50.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:45:0)
[06:20:50.551] Timer tick, asking Buildbucket for the build status
[06:20:54.955] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:54.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:46:0) after 1m0s
[06:21:55.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:46:0)
[06:21:55.047] Timer tick, asking Buildbucket for the build status
[06:21:56.446] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:56.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:47:0) after 1m0s
[06:22:56.515] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:47:0)
[06:22:56.515] Timer tick, asking Buildbucket for the build status
[06:22:56.816] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:56.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:48:0) after 1m0s
[06:23:56.875] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:48:0)
[06:23:56.875] Timer tick, asking Buildbucket for the build status
[06:23:57.042] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:57.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:49:0) after 1m0s
[06:24:57.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:49:0)
[06:24:57.124] Timer tick, asking Buildbucket for the build status
[06:24:57.347] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:57.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:50:0) after 1m0s
[06:25:57.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:50:0)
[06:25:57.453] Timer tick, asking Buildbucket for the build status
[06:25:57.578] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:57.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:51:0) after 1m0s
[06:26:57.761] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:51:0)
[06:26:57.761] Timer tick, asking Buildbucket for the build status
[06:26:58.062] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:58.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:52:0) after 1m0s
[06:27:58.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:52:0)
[06:27:58.093] Timer tick, asking Buildbucket for the build status
[06:27:58.317] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:58.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:53:0) after 1m0s
[06:28:58.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:53:0)
[06:28:58.372] Timer tick, asking Buildbucket for the build status
[06:28:58.751] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:58.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:54:0) after 1m0s
[06:29:58.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:54:0)
[06:29:58.813] Timer tick, asking Buildbucket for the build status
[06:29:59.022] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:59.022] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:55:0) after 1m0s
[06:30:59.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:55:0)
[06:30:59.077] Timer tick, asking Buildbucket for the build status
[06:30:59.352] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:59.352] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:56:0) after 1m0s
[06:31:59.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:56:0)
[06:31:59.469] Timer tick, asking Buildbucket for the build status
[06:31:59.924] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:59.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:57:0) after 1m0s
[06:32:59.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:57:0)
[06:32:59.925] Timer tick, asking Buildbucket for the build status
[06:33:00.277] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:00.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:58:0) after 1m0s
[06:34:00.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:58:0)
[06:34:00.373] Timer tick, asking Buildbucket for the build status
[06:34:00.472] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:00.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:59:0) after 1m0s
[06:35:00.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:59:0)
[06:35:00.574] Timer tick, asking Buildbucket for the build status
[06:35:00.919] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:00.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:60:0) after 1m0s
[06:36:00.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:60:0)
[06:36:00.975] Timer tick, asking Buildbucket for the build status
[06:36:01.111] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:01.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:61:0) after 1m0s
[06:37:01.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:61:0)
[06:37:01.233] Timer tick, asking Buildbucket for the build status
[06:37:01.443] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:01.443] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:62:0) after 1m0s
[06:38:01.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:62:0)
[06:38:01.488] Timer tick, asking Buildbucket for the build status
[06:38:01.626] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:01.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:63:0) after 1m0s
[06:39:01.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:63:0)
[06:39:01.659] Timer tick, asking Buildbucket for the build status
[06:39:01.842] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:01.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:64:0) after 1m0s
[06:40:01.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:64:0)
[06:40:01.955] Timer tick, asking Buildbucket for the build status
[06:40:04.438] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:04.438] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:65:0) after 1m0s
[06:41:04.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:65:0)
[06:41:04.501] Timer tick, asking Buildbucket for the build status
[06:41:05.038] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:66:0) after 1m0s
[06:42:05.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:66:0)
[06:42:05.078] Timer tick, asking Buildbucket for the build status
[06:42:05.225] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:05.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:67:0) after 1m0s
[06:43:05.250] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:67:0)
[06:43:05.250] Timer tick, asking Buildbucket for the build status
[06:43:05.369] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:05.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:68:0) after 1m0s
[06:44:05.357] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:68:0)
[06:44:05.357] Timer tick, asking Buildbucket for the build status
[06:44:05.647] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:05.647] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:69:0) after 1m0s
[06:45:05.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:69:0)
[06:45:05.750] Timer tick, asking Buildbucket for the build status
[06:45:06.666] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:06.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:70:0) after 1m0s
[06:46:06.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:70:0)
[06:46:06.769] Timer tick, asking Buildbucket for the build status
[06:46:06.930] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:06.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:71:0) after 1m0s
[06:47:06.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:71:0)
[06:47:06.956] Timer tick, asking Buildbucket for the build status
[06:47:07.088] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:72:0) after 1m0s
[06:48:07.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:72:0)
[06:48:07.193] Timer tick, asking Buildbucket for the build status
[06:48:07.411] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:07.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:73:0) after 1m0s
[06:49:07.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:73:0)
[06:49:07.401] Timer tick, asking Buildbucket for the build status
[06:49:07.529] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:07.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:74:0) after 1m0s
[06:50:07.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:74:0)
[06:50:07.559] Timer tick, asking Buildbucket for the build status
[06:50:07.816] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:07.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:75:0) after 1m0s
[06:51:07.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:75:0)
[06:51:07.892] Timer tick, asking Buildbucket for the build status
[06:51:08.013] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:08.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:76:0) after 1m0s
[06:52:08.072] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:76:0)
[06:52:08.072] Timer tick, asking Buildbucket for the build status
[06:52:08.240] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:08.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:77:0) after 1m0s
[06:53:08.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:77:0)
[06:53:08.325] Timer tick, asking Buildbucket for the build status
[06:53:08.480] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:08.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:78:0) after 1m0s
[06:54:08.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:78:0)
[06:54:08.571] Timer tick, asking Buildbucket for the build status
[06:54:08.789] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:08.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:79:0) after 1m0s
[06:55:08.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:79:0)
[06:55:08.810] Timer tick, asking Buildbucket for the build status
[06:55:09.019] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:09.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:80:0) after 1m0s
[06:56:09.082] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:80:0)
[06:56:09.082] Timer tick, asking Buildbucket for the build status
[06:56:09.319] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:09.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:81:0) after 1m0s
[06:57:09.393] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:81:0)
[06:57:09.393] Timer tick, asking Buildbucket for the build status
[06:57:09.571] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:09.571] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:82:0) after 1m0s
[06:58:09.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:82:0)
[06:58:09.741] Timer tick, asking Buildbucket for the build status
[06:58:10.102] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:10.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:83:0) after 1m0s
[06:59:10.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:83:0)
[06:59:10.248] Timer tick, asking Buildbucket for the build status
[06:59:10.372] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:10.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:84:0) after 1m0s
[07:00:10.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:84:0)
[07:00:10.411] Timer tick, asking Buildbucket for the build status
[07:00:13.452] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:13.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:85:0) after 1m0s
[07:01:13.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:85:0)
[07:01:13.470] Timer tick, asking Buildbucket for the build status
[07:01:13.652] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:13.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:86:0) after 1m0s
[07:02:13.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:86:0)
[07:02:13.683] Timer tick, asking Buildbucket for the build status
[07:02:14.006] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:14.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:87:0) after 1m0s
[07:03:14.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:87:0)
[07:03:14.065] Timer tick, asking Buildbucket for the build status
[07:03:14.298] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:14.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:88:0) after 1m0s
[07:04:14.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:88:0)
[07:04:14.382] Timer tick, asking Buildbucket for the build status
[07:04:14.690] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:14.690] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:89:0) after 1m0s
[07:05:14.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:89:0)
[07:05:14.698] Timer tick, asking Buildbucket for the build status
[07:05:14.953] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:14.953] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:90:0) after 1m0s
[07:06:14.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:90:0)
[07:06:14.981] Timer tick, asking Buildbucket for the build status
[07:06:15.728] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:15.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:91:0) after 1m0s
[07:07:15.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:91:0)
[07:07:15.714] Timer tick, asking Buildbucket for the build status
[07:07:16.294] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:16.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:92:0) after 1m0s
[07:08:16.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:92:0)
[07:08:16.322] Timer tick, asking Buildbucket for the build status
[07:08:21.192] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:21.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:93:0) after 1m0s
[07:09:21.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:93:0)
[07:09:21.626] Timer tick, asking Buildbucket for the build status
[07:09:21.750] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:21.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:94:0) after 1m0s
[07:10:21.799] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:94:0)
[07:10:21.799] Timer tick, asking Buildbucket for the build status
[07:10:21.937] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:21.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:95:0) after 1m0s
[07:11:21.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:95:0)
[07:11:21.964] Timer tick, asking Buildbucket for the build status
[07:11:22.120] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:22.120] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:96:0) after 1m0s
[07:12:22.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:96:0)
[07:12:22.268] Timer tick, asking Buildbucket for the build status
[07:12:22.368] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:22.368] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:97:0) after 1m0s
[07:13:22.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:97:0)
[07:13:22.416] Timer tick, asking Buildbucket for the build status
[07:13:22.708] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:22.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:98:0) after 1m0s
[07:14:22.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:98:0)
[07:14:22.861] Timer tick, asking Buildbucket for the build status
[07:14:23.052] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:23.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:99:0) after 1m0s
[07:15:23.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:99:0)
[07:15:23.338] Timer tick, asking Buildbucket for the build status
[07:15:23.559] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:23.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:100:0) after 1m0s
[07:16:23.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:100:0)
[07:16:23.686] Timer tick, asking Buildbucket for the build status
[07:16:24.451] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:24.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:101:0) after 1m0s
[07:17:24.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:101:0)
[07:17:24.558] Timer tick, asking Buildbucket for the build status
[07:17:24.708] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:24.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:102:0) after 1m0s
[07:18:24.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:102:0)
[07:18:24.780] Timer tick, asking Buildbucket for the build status
[07:18:25.302] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:25.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:103:0) after 1m0s
[07:19:25.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:103:0)
[07:19:25.339] Timer tick, asking Buildbucket for the build status
[07:19:25.858] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:25.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:104:0) after 1m0s
[07:20:25.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:104:0)
[07:20:25.891] Timer tick, asking Buildbucket for the build status
[07:20:26.955] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:26.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:105:0) after 1m0s
[07:21:27.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:105:0)
[07:21:27.005] Timer tick, asking Buildbucket for the build status
[07:21:27.135] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:27.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:106:0) after 1m0s
[07:22:27.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:106:0)
[07:22:27.163] Timer tick, asking Buildbucket for the build status
[07:22:27.629] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:27.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:107:0) after 1m0s
[07:23:27.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:107:0)
[07:23:27.655] Timer tick, asking Buildbucket for the build status
[07:23:27.847] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:27.847] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:108:0) after 1m0s
[07:24:27.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:108:0)
[07:24:27.887] Timer tick, asking Buildbucket for the build status
[07:24:28.132] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:28.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:109:0) after 1m0s
[07:25:28.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:109:0)
[07:25:28.164] Timer tick, asking Buildbucket for the build status
[07:25:28.339] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:28.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:110:0) after 1m0s
[07:26:28.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:110:0)
[07:26:28.337] Timer tick, asking Buildbucket for the build status
[07:26:29.510] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:29.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:111:0) after 1m0s
[07:27:29.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:111:0)
[07:27:29.534] Timer tick, asking Buildbucket for the build status
[07:27:31.270] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:31.270] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:112:0) after 1m0s
[07:28:31.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:112:0)
[07:28:31.362] Timer tick, asking Buildbucket for the build status
[07:28:32.405] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:32.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:113:0) after 1m0s
[07:29:32.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:113:0)
[07:29:32.506] Timer tick, asking Buildbucket for the build status
[07:29:32.618] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:32.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:114:0) after 1m0s
[07:30:32.727] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:114:0)
[07:30:32.727] Timer tick, asking Buildbucket for the build status
[07:30:33.152] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:33.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:115:0) after 1m0s
[07:31:33.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:115:0)
[07:31:33.382] Timer tick, asking Buildbucket for the build status
[07:31:34.531] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:34.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:116:0) after 1m0s
[07:32:34.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:116:0)
[07:32:34.639] Timer tick, asking Buildbucket for the build status
[07:32:34.774] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:34.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:117:0) after 1m0s
[07:33:34.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:117:0)
[07:33:34.806] Timer tick, asking Buildbucket for the build status
[07:33:35.340] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:35.340] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:118:0) after 1m0s
[07:34:35.366] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:118:0)
[07:34:35.366] Timer tick, asking Buildbucket for the build status
[07:34:35.532] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:35.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:119:0) after 1m0s
[07:35:35.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:119:0)
[07:35:35.605] Timer tick, asking Buildbucket for the build status
[07:35:35.861] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:35.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:120:0) after 1m0s
[07:36:35.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:120:0)
[07:36:35.962] Timer tick, asking Buildbucket for the build status
[07:36:36.105] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:36.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:121:0) after 1m0s
[07:37:36.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:121:0)
[07:37:36.213] Timer tick, asking Buildbucket for the build status
[07:37:36.420] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:36.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:122:0) after 1m0s
[07:38:36.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:122:0)
[07:38:36.507] Timer tick, asking Buildbucket for the build status
[07:38:36.674] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:36.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:123:0) after 1m0s
[07:39:36.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:123:0)
[07:39:36.743] Timer tick, asking Buildbucket for the build status
[07:39:36.949] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:36.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:124:0) after 1m0s
[07:40:37.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:124:0)
[07:40:37.164] Timer tick, asking Buildbucket for the build status
[07:40:37.339] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:37.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:125:0) after 1m0s
[07:41:37.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:125:0)
[07:41:37.465] Timer tick, asking Buildbucket for the build status
[07:41:37.790] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:37.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:126:0) after 1m0s
[07:42:37.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:126:0)
[07:42:37.815] Timer tick, asking Buildbucket for the build status
[07:42:38.379] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:38.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:127:0) after 1m0s
[07:43:38.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:127:0)
[07:43:38.490] Timer tick, asking Buildbucket for the build status
[07:43:38.818] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:38.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:128:0) after 1m0s
[07:44:38.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:128:0)
[07:44:38.825] Timer tick, asking Buildbucket for the build status
[07:44:38.935] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:38.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:129:0) after 1m0s
[07:45:38.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:129:0)
[07:45:38.971] Timer tick, asking Buildbucket for the build status
[07:45:39.557] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:39.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:130:0) after 1m0s
[07:46:39.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:130:0)
[07:46:39.596] Timer tick, asking Buildbucket for the build status
[07:46:39.900] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:39.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:131:0) after 1m0s
[07:47:39.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:131:0)
[07:47:39.998] Timer tick, asking Buildbucket for the build status
[07:47:40.156] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:40.156] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:132:0) after 1m0s
[07:48:40.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:132:0)
[07:48:40.257] Timer tick, asking Buildbucket for the build status
[07:48:40.383] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:40.383] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:133:0) after 1m0s
[07:49:40.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:133:0)
[07:49:40.428] Timer tick, asking Buildbucket for the build status
[07:49:40.563] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:40.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:134:0) after 1m0s
[07:50:40.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:134:0)
[07:50:40.561] Timer tick, asking Buildbucket for the build status
[07:50:40.725] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:40.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:135:0) after 1m0s
[07:51:40.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:135:0)
[07:51:40.785] Timer tick, asking Buildbucket for the build status
[07:51:41.004] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:41.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:136:0) after 1m0s
[07:52:41.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:136:0)
[07:52:41.149] Timer tick, asking Buildbucket for the build status
[07:52:41.577] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:41.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:137:0) after 1m0s
[07:53:41.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:137:0)
[07:53:41.750] Timer tick, asking Buildbucket for the build status
[07:53:41.943] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:41.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:138:0) after 1m0s
[07:54:42.058] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:138:0)
[07:54:42.058] Timer tick, asking Buildbucket for the build status
[07:54:42.229] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:42.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:139:0) after 1m0s
[07:55:42.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:139:0)
[07:55:42.300] Timer tick, asking Buildbucket for the build status
[07:55:42.454] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:42.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:140:0) after 1m0s
[07:56:42.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:140:0)
[07:56:42.501] Timer tick, asking Buildbucket for the build status
[07:56:42.643] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:42.643] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:141:0) after 1m0s
[07:57:42.743] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:141:0)
[07:57:42.743] Timer tick, asking Buildbucket for the build status
[07:57:43.186] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:43.186] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:142:0) after 1m0s
[07:58:43.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:142:0)
[07:58:43.183] Timer tick, asking Buildbucket for the build status
[07:58:43.742] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:43.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:143:0) after 1m0s
[07:59:43.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:143:0)
[07:59:43.800] Timer tick, asking Buildbucket for the build status
[07:59:43.967] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:43.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:144:0) after 1m0s
[08:00:44.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:144:0)
[08:00:44.012] Timer tick, asking Buildbucket for the build status
[08:00:44.199] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:44.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:145:0) after 1m0s
[08:01:44.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:145:0)
[08:01:44.401] Timer tick, asking Buildbucket for the build status
[08:01:44.661] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:44.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:146:0) after 1m0s
[08:02:44.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:146:0)
[08:02:44.818] Timer tick, asking Buildbucket for the build status
[08:02:45.182] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:45.182] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:147:0) after 1m0s
[08:03:45.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:147:0)
[08:03:45.256] Timer tick, asking Buildbucket for the build status
[08:03:46.073] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:46.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:148:0) after 1m0s
[08:04:46.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:148:0)
[08:04:46.114] Timer tick, asking Buildbucket for the build status
[08:04:46.611] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:46.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:149:0) after 1m0s
[08:05:46.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:149:0)
[08:05:46.638] Timer tick, asking Buildbucket for the build status
[08:05:46.816] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:46.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:150:0) after 1m0s
[08:06:46.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:150:0)
[08:06:46.889] Timer tick, asking Buildbucket for the build status
[08:06:47.252] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:47.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:151:0) after 1m0s
[08:07:47.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:151:0)
[08:07:47.338] Timer tick, asking Buildbucket for the build status
[08:07:47.686] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:47.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:152:0) after 1m0s
[08:08:47.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:152:0)
[08:08:47.714] Timer tick, asking Buildbucket for the build status
[08:08:48.390] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:48.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:153:0) after 1m0s
[08:09:49.362] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:153:0)
[08:09:49.362] Timer tick, asking Buildbucket for the build status
[08:09:49.615] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:49.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:154:0) after 1m0s
[08:10:49.675] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:154:0)
[08:10:49.675] Timer tick, asking Buildbucket for the build status
[08:10:49.893] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:49.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:155:0) after 1m0s
[08:11:49.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:155:0)
[08:11:49.951] Timer tick, asking Buildbucket for the build status
[08:11:50.193] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:50.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:156:0) after 1m0s
[08:12:50.309] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:156:0)
[08:12:50.309] Timer tick, asking Buildbucket for the build status
[08:12:50.430] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:50.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:157:0) after 1m0s
[08:13:50.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:157:0)
[08:13:50.643] Timer tick, asking Buildbucket for the build status
[08:13:50.789] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:50.789] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:158:0) after 1m0s
[08:14:50.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:158:0)
[08:14:50.895] Timer tick, asking Buildbucket for the build status
[08:14:51.037] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:51.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:159:0) after 1m0s
[08:15:51.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:159:0)
[08:15:51.135] Timer tick, asking Buildbucket for the build status
[08:15:51.273] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:51.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:160:0) after 1m0s
[08:16:51.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:160:0)
[08:16:51.473] Timer tick, asking Buildbucket for the build status
[08:16:51.604] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:51.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:161:0) after 1m0s
[08:17:51.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:161:0)
[08:17:51.705] Timer tick, asking Buildbucket for the build status
[08:17:51.947] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:51.947] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:162:0) after 1m0s
[08:18:52.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:162:0)
[08:18:52.061] Timer tick, asking Buildbucket for the build status
[08:18:52.411] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:52.411] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:163:0) after 1m0s
[08:19:52.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:163:0)
[08:19:52.433] Timer tick, asking Buildbucket for the build status
[08:19:52.609] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:52.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:164:0) after 1m0s
[08:20:52.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:164:0)
[08:20:52.644] Timer tick, asking Buildbucket for the build status
[08:20:53.035] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:53.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:165:0) after 1m0s
[08:21:53.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:165:0)
[08:21:53.147] Timer tick, asking Buildbucket for the build status
[08:21:53.362] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:53.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:166:0) after 1m0s
[08:22:53.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:166:0)
[08:22:53.417] Timer tick, asking Buildbucket for the build status
[08:22:53.575] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:53.575] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:167:0) after 1m0s
[08:23:53.608] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:167:0)
[08:23:53.608] Timer tick, asking Buildbucket for the build status
[08:23:53.730] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:53.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:168:0) after 1m0s
[08:24:53.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:168:0)
[08:24:53.805] Timer tick, asking Buildbucket for the build status
[08:24:53.941] Build 8884336949130401296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:53.941] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049767011246614192:169:0) after 1m0s
[08:25:20.279] Received PubSub notification, asking Buildbucket for the build status
[08:25:20.348] Build 8884336949130401296: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:25:20.349] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1585643119602546",
"created_by": "project:infra",
"created_ts": "1585633055523813",
"id": "8884336949130401296",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4099.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3b809007-ddbe-4aa1-8da4-d8cb2690b3ef\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4099.4\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4099.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3b809007-ddbe-4aa1-8da4-d8cb2690b3ef\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-cqq7\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4099.4\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"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-cqq7\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4910-0007b8d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585633089390526",
"status": "COMPLETED",
"status_changed_ts": "1585643119942241",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9049767011246614192",
"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/8884336949130401296/+/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:4b47e9df37138610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1585643119970944",
"url": "https://ci.chromium.org/b/8884336949130401296",
"utcnow_ts": "1585643120339100"
}
}
[08:25:20.349] Invocation finished in 2h47m46.228014265s with status SUCCEEDED