[07:51:36.083] New invocation is queued and will start shortly
[07:51:36.083] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[07:51:37.213] Starting the invocation (attempt 1)
[07:51:37.251] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:51:37.251] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:51:37.251] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9019136804012049856",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"89.0.4389.76\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"a78ed0e3-a7d9-4651-98e3-216842b771e2\",\"title\":\"publish_tarball/0\"}]},\"version\":\"89.0.4389.76\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9019136804012049856",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[07:51:37.874] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1614844297414014",
"id": "8853706741952809152",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4389.76\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a78ed0e3-a7d9-4651-98e3-216842b771e2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4389.76\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614844297625513",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9019136804012049856",
"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/8853706741952809152/+/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": "1614844297625661",
"url": "https://ci.chromium.org/b/8853706741952809152",
"utcnow_ts": "1614844297867310"
}
}
[07:51:37.874] Task URL: https://ci.chromium.org/b/8853706741952809152
[07:51:37.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:2:0) after 1m0s
[07:52:06.021] Received PubSub notification, asking Buildbucket for the build status
[07:52:06.107] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:38.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:2:0)
[07:52:38.041] Timer tick, asking Buildbucket for the build status
[07:52:38.108] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:38.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:4:0) after 1m0s
[07:53:38.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:4:0)
[07:53:38.166] Timer tick, asking Buildbucket for the build status
[07:53:38.862] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:38.862] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:5:0) after 1m0s
[07:54:38.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:5:0)
[07:54:38.986] Timer tick, asking Buildbucket for the build status
[07:54:39.122] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:39.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:6:0) after 1m0s
[07:55:39.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:6:0)
[07:55:39.203] Timer tick, asking Buildbucket for the build status
[07:55:39.334] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:39.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:7:0) after 1m0s
[07:56:39.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:7:0)
[07:56:39.354] Timer tick, asking Buildbucket for the build status
[07:56:39.431] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:39.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:8:0) after 1m0s
[07:57:39.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:8:0)
[07:57:39.521] Timer tick, asking Buildbucket for the build status
[07:57:39.636] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:39.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:9:0) after 1m0s
[07:58:39.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:9:0)
[07:58:39.703] Timer tick, asking Buildbucket for the build status
[07:58:39.770] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:39.770] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:10:0) after 1m0s
[07:59:39.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:10:0)
[07:59:39.787] Timer tick, asking Buildbucket for the build status
[07:59:39.859] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:39.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:11:0) after 1m0s
[08:00:40.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:11:0)
[08:00:40.886] Timer tick, asking Buildbucket for the build status
[08:00:40.969] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:40.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:12:0) after 1m0s
[08:01:41.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:12:0)
[08:01:41.003] Timer tick, asking Buildbucket for the build status
[08:01:41.244] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:41.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:13:0) after 1m0s
[08:02:41.235] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:13:0)
[08:02:41.235] Timer tick, asking Buildbucket for the build status
[08:02:41.310] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:41.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:14:0) after 1m0s
[08:03:41.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:14:0)
[08:03:41.334] Timer tick, asking Buildbucket for the build status
[08:03:41.528] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:41.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:15:0) after 1m0s
[08:04:41.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:15:0)
[08:04:41.558] Timer tick, asking Buildbucket for the build status
[08:04:41.836] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:41.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:16:0) after 1m0s
[08:05:41.865] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:16:0)
[08:05:41.865] Timer tick, asking Buildbucket for the build status
[08:05:41.938] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:41.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:17:0) after 1m0s
[08:06:42.055] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:17:0)
[08:06:42.056] Timer tick, asking Buildbucket for the build status
[08:06:42.407] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:42.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:18:0) after 1m0s
[08:07:42.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:18:0)
[08:07:42.427] Timer tick, asking Buildbucket for the build status
[08:07:44.370] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:44.370] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:19:0) after 1m0s
[08:08:44.624] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:19:0)
[08:08:44.624] Timer tick, asking Buildbucket for the build status
[08:08:44.785] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:44.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:20:0) after 1m0s
[08:09:44.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:20:0)
[08:09:44.782] Timer tick, asking Buildbucket for the build status
[08:09:45.121] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:45.121] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:21:0) after 1m0s
[08:10:45.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:21:0)
[08:10:45.141] Timer tick, asking Buildbucket for the build status
[08:10:45.236] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:45.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:22:0) after 1m0s
[08:11:45.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:22:0)
[08:11:45.310] Timer tick, asking Buildbucket for the build status
[08:11:45.392] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:45.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:23:0) after 1m0s
[08:12:45.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:23:0)
[08:12:45.480] Timer tick, asking Buildbucket for the build status
[08:12:45.950] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:45.950] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:24:0) after 1m0s
[08:13:46.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:24:0)
[08:13:46.025] Timer tick, asking Buildbucket for the build status
[08:13:46.216] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:46.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:25:0) after 1m0s
[08:14:46.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:25:0)
[08:14:46.246] Timer tick, asking Buildbucket for the build status
[08:14:46.312] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:46.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:26:0) after 1m0s
[08:15:46.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:26:0)
[08:15:46.411] Timer tick, asking Buildbucket for the build status
[08:15:46.607] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:46.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:27:0) after 1m0s
[08:16:46.812] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:27:0)
[08:16:46.812] Timer tick, asking Buildbucket for the build status
[08:16:46.897] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:46.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:28:0) after 1m0s
[08:17:47.016] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:28:0)
[08:17:47.016] Timer tick, asking Buildbucket for the build status
[08:17:47.614] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:47.614] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:29:0) after 1m0s
[08:18:54.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:29:0)
[08:18:54.522] Timer tick, asking Buildbucket for the build status
[08:18:54.812] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:54.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:30:0) after 1m0s
[08:19:54.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:30:0)
[08:19:54.849] Timer tick, asking Buildbucket for the build status
[08:19:54.977] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:54.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:31:0) after 1m0s
[08:20:55.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:31:0)
[08:20:55.047] Timer tick, asking Buildbucket for the build status
[08:20:55.142] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:55.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:32:0) after 1m0s
[08:21:55.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:32:0)
[08:21:55.145] Timer tick, asking Buildbucket for the build status
[08:21:55.359] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:55.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:33:0) after 1m0s
[08:22:55.395] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:33:0)
[08:22:55.395] Timer tick, asking Buildbucket for the build status
[08:22:55.471] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:55.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:34:0) after 1m0s
[08:23:55.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:34:0)
[08:23:55.493] Timer tick, asking Buildbucket for the build status
[08:23:55.813] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:55.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:35:0) after 1m0s
[08:24:55.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:35:0)
[08:24:55.881] Timer tick, asking Buildbucket for the build status
[08:24:55.952] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:55.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:36:0) after 1m0s
[08:25:55.948] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:36:0)
[08:25:55.948] Timer tick, asking Buildbucket for the build status
[08:25:56.027] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:56.027] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:37:0) after 1m0s
[08:26:56.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:37:0)
[08:26:56.083] Timer tick, asking Buildbucket for the build status
[08:26:56.178] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:56.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:38:0) after 1m0s
[08:27:56.201] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:38:0)
[08:27:56.201] Timer tick, asking Buildbucket for the build status
[08:27:56.286] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:56.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:39:0) after 1m0s
[08:28:56.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:39:0)
[08:28:56.370] Timer tick, asking Buildbucket for the build status
[08:28:56.637] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:56.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:40:0) after 1m0s
[08:29:56.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:40:0)
[08:29:56.665] Timer tick, asking Buildbucket for the build status
[08:29:56.733] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:56.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:41:0) after 1m0s
[08:30:56.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:41:0)
[08:30:56.785] Timer tick, asking Buildbucket for the build status
[08:30:56.894] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:56.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:42:0) after 1m0s
[08:31:56.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:42:0)
[08:31:56.920] Timer tick, asking Buildbucket for the build status
[08:31:57.007] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:57.007] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:43:0) after 1m0s
[08:32:57.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:43:0)
[08:32:57.038] Timer tick, asking Buildbucket for the build status
[08:32:57.158] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:57.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:44:0) after 1m0s
[08:33:57.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:44:0)
[08:33:57.186] Timer tick, asking Buildbucket for the build status
[08:33:57.255] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:57.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:45:0) after 1m0s
[08:34:57.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:45:0)
[08:34:57.273] Timer tick, asking Buildbucket for the build status
[08:34:57.347] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:57.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:46:0) after 1m0s
[08:35:57.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:46:0)
[08:35:57.375] Timer tick, asking Buildbucket for the build status
[08:35:57.449] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:57.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:47:0) after 1m0s
[08:36:57.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:47:0)
[08:36:57.457] Timer tick, asking Buildbucket for the build status
[08:36:57.538] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:57.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:48:0) after 1m0s
[08:37:57.741] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:48:0)
[08:37:57.741] Timer tick, asking Buildbucket for the build status
[08:37:58.149] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:58.149] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:49:0) after 1m0s
[08:38:58.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:49:0)
[08:38:58.326] Timer tick, asking Buildbucket for the build status
[08:38:58.399] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:58.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:50:0) after 1m0s
[08:39:58.740] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:50:0)
[08:39:58.740] Timer tick, asking Buildbucket for the build status
[08:39:58.812] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:58.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:51:0) after 1m0s
[08:40:58.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:51:0)
[08:40:58.830] Timer tick, asking Buildbucket for the build status
[08:40:58.885] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:58.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:52:0) after 1m0s
[08:41:58.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:52:0)
[08:41:58.941] Timer tick, asking Buildbucket for the build status
[08:41:59.052] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:59.052] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:53:0) after 1m0s
[08:42:59.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:53:0)
[08:42:59.105] Timer tick, asking Buildbucket for the build status
[08:42:59.167] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:59.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:54:0) after 1m0s
[08:43:59.184] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:54:0)
[08:43:59.184] Timer tick, asking Buildbucket for the build status
[08:44:00.356] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:00.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:55:0) after 1m0s
[08:45:00.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:55:0)
[08:45:00.352] Timer tick, asking Buildbucket for the build status
[08:45:00.423] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:00.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:56:0) after 1m0s
[08:46:00.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:56:0)
[08:46:00.560] Timer tick, asking Buildbucket for the build status
[08:46:00.648] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:00.648] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:57:0) after 1m0s
[08:47:00.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:57:0)
[08:47:00.713] Timer tick, asking Buildbucket for the build status
[08:47:00.843] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:00.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:58:0) after 1m0s
[08:48:00.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:58:0)
[08:48:00.841] Timer tick, asking Buildbucket for the build status
[08:48:00.912] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:00.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:59:0) after 1m0s
[08:49:01.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:59:0)
[08:49:01.618] Timer tick, asking Buildbucket for the build status
[08:49:01.692] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:01.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:60:0) after 1m0s
[08:50:01.742] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:60:0)
[08:50:01.742] Timer tick, asking Buildbucket for the build status
[08:50:01.834] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:01.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:61:0) after 1m0s
[08:51:01.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:61:0)
[08:51:01.846] Timer tick, asking Buildbucket for the build status
[08:51:01.924] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:01.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:62:0) after 1m0s
[08:52:01.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:62:0)
[08:52:01.925] Timer tick, asking Buildbucket for the build status
[08:52:01.997] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:01.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:63:0) after 1m0s
[08:53:02.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:63:0)
[08:53:02.107] Timer tick, asking Buildbucket for the build status
[08:53:02.218] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:02.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:64:0) after 1m0s
[08:54:02.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:64:0)
[08:54:02.519] Timer tick, asking Buildbucket for the build status
[08:54:02.607] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:02.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:65:0) after 1m0s
[08:55:02.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:65:0)
[08:55:02.935] Timer tick, asking Buildbucket for the build status
[08:55:02.994] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:02.994] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:66:0) after 1m0s
[08:56:03.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:66:0)
[08:56:03.107] Timer tick, asking Buildbucket for the build status
[08:56:03.431] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:03.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:67:0) after 1m0s
[08:57:03.471] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:67:0)
[08:57:03.471] Timer tick, asking Buildbucket for the build status
[08:57:03.639] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:03.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:68:0) after 1m0s
[08:58:03.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:68:0)
[08:58:03.809] Timer tick, asking Buildbucket for the build status
[08:58:03.952] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:03.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:69:0) after 1m0s
[08:59:04.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:69:0)
[08:59:04.063] Timer tick, asking Buildbucket for the build status
[08:59:04.194] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:04.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:70:0) after 1m0s
[09:00:04.473] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:70:0)
[09:00:04.473] Timer tick, asking Buildbucket for the build status
[09:00:04.768] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:04.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:71:0) after 1m0s
[09:01:05.022] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:71:0)
[09:01:05.022] Timer tick, asking Buildbucket for the build status
[09:01:05.556] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:05.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:72:0) after 1m0s
[09:02:05.669] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:72:0)
[09:02:05.669] Timer tick, asking Buildbucket for the build status
[09:02:06.096] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:06.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:73:0) after 1m0s
[09:03:06.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:73:0)
[09:03:06.226] Timer tick, asking Buildbucket for the build status
[09:03:06.557] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:06.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:74:0) after 1m0s
[09:04:06.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:74:0)
[09:04:06.856] Timer tick, asking Buildbucket for the build status
[09:04:06.930] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:06.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:75:0) after 1m0s
[09:05:07.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:75:0)
[09:05:07.065] Timer tick, asking Buildbucket for the build status
[09:05:07.160] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:07.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:76:0) after 1m0s
[09:06:07.263] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:76:0)
[09:06:07.263] Timer tick, asking Buildbucket for the build status
[09:06:08.097] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:08.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:77:0) after 1m0s
[09:07:08.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:77:0)
[09:07:08.155] Timer tick, asking Buildbucket for the build status
[09:07:08.235] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:08.235] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:78:0) after 1m0s
[09:08:08.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:78:0)
[09:08:08.282] Timer tick, asking Buildbucket for the build status
[09:08:08.347] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:08.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:79:0) after 1m0s
[09:09:08.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:79:0)
[09:09:08.405] Timer tick, asking Buildbucket for the build status
[09:09:08.477] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:08.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:80:0) after 1m0s
[09:10:08.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:80:0)
[09:10:08.499] Timer tick, asking Buildbucket for the build status
[09:10:08.666] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:08.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:81:0) after 1m0s
[09:11:08.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:81:0)
[09:11:08.691] Timer tick, asking Buildbucket for the build status
[09:11:08.758] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:08.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:82:0) after 1m0s
[09:12:08.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:82:0)
[09:12:08.789] Timer tick, asking Buildbucket for the build status
[09:12:08.860] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:08.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:83:0) after 1m0s
[09:13:08.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:83:0)
[09:13:08.878] Timer tick, asking Buildbucket for the build status
[09:13:08.968] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:08.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:84:0) after 1m0s
[09:14:09.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:84:0)
[09:14:09.127] Timer tick, asking Buildbucket for the build status
[09:14:09.190] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:09.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:85:0) after 1m0s
[09:15:09.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:85:0)
[09:15:09.311] Timer tick, asking Buildbucket for the build status
[09:15:09.414] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:09.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:86:0) after 1m0s
[09:16:09.478] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:86:0)
[09:16:09.478] Timer tick, asking Buildbucket for the build status
[09:16:09.542] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:09.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:87:0) after 1m0s
[09:17:09.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:87:0)
[09:17:09.600] Timer tick, asking Buildbucket for the build status
[09:17:09.717] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:09.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:88:0) after 1m0s
[09:18:09.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:88:0)
[09:18:09.690] Timer tick, asking Buildbucket for the build status
[09:18:09.754] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:09.754] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:89:0) after 1m0s
[09:19:09.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:89:0)
[09:19:09.792] Timer tick, asking Buildbucket for the build status
[09:19:09.865] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:09.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:90:0) after 1m0s
[09:20:09.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:90:0)
[09:20:09.939] Timer tick, asking Buildbucket for the build status
[09:20:10.001] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:10.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:91:0) after 1m0s
[09:21:10.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:91:0)
[09:21:10.035] Timer tick, asking Buildbucket for the build status
[09:21:10.250] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:10.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:92:0) after 1m0s
[09:22:10.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:92:0)
[09:22:10.300] Timer tick, asking Buildbucket for the build status
[09:22:10.563] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:10.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:93:0) after 1m0s
[09:23:10.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:93:0)
[09:23:10.584] Timer tick, asking Buildbucket for the build status
[09:23:10.826] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:10.826] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:94:0) after 1m0s
[09:24:10.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:94:0)
[09:24:10.877] Timer tick, asking Buildbucket for the build status
[09:24:11.267] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:11.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:95:0) after 1m0s
[09:25:11.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:95:0)
[09:25:11.286] Timer tick, asking Buildbucket for the build status
[09:25:11.530] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:11.530] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:96:0) after 1m0s
[09:26:11.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:96:0)
[09:26:11.601] Timer tick, asking Buildbucket for the build status
[09:26:11.660] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:11.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:97:0) after 1m0s
[09:27:11.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:97:0)
[09:27:11.678] Timer tick, asking Buildbucket for the build status
[09:27:11.854] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:11.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:98:0) after 1m0s
[09:28:11.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:98:0)
[09:28:11.899] Timer tick, asking Buildbucket for the build status
[09:28:11.977] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:11.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:99:0) after 1m0s
[09:29:11.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:99:0)
[09:29:11.963] Timer tick, asking Buildbucket for the build status
[09:29:12.069] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:12.069] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:100:0) after 1m0s
[09:30:12.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:100:0)
[09:30:12.089] Timer tick, asking Buildbucket for the build status
[09:30:12.154] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:12.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:101:0) after 1m0s
[09:31:12.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:101:0)
[09:31:12.239] Timer tick, asking Buildbucket for the build status
[09:31:12.373] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:12.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:102:0) after 1m0s
[09:32:12.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:102:0)
[09:32:12.419] Timer tick, asking Buildbucket for the build status
[09:32:12.519] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:12.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:103:0) after 1m0s
[09:33:13.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:103:0)
[09:33:13.433] Timer tick, asking Buildbucket for the build status
[09:33:13.619] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:13.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:104:0) after 1m0s
[09:34:13.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:104:0)
[09:34:13.768] Timer tick, asking Buildbucket for the build status
[09:34:13.845] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:13.845] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:105:0) after 1m0s
[09:35:13.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:105:0)
[09:35:13.977] Timer tick, asking Buildbucket for the build status
[09:35:14.049] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:14.049] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:106:0) after 1m0s
[09:36:14.183] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:106:0)
[09:36:14.183] Timer tick, asking Buildbucket for the build status
[09:36:14.255] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:14.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:107:0) after 1m0s
[09:37:14.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:107:0)
[09:37:14.317] Timer tick, asking Buildbucket for the build status
[09:37:14.406] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:14.406] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:108:0) after 1m0s
[09:38:14.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:108:0)
[09:38:14.496] Timer tick, asking Buildbucket for the build status
[09:38:14.572] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:14.572] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:109:0) after 1m0s
[09:39:14.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:109:0)
[09:39:14.713] Timer tick, asking Buildbucket for the build status
[09:39:14.785] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:14.785] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:110:0) after 1m0s
[09:40:14.973] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:110:0)
[09:40:14.973] Timer tick, asking Buildbucket for the build status
[09:40:15.056] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:15.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:111:0) after 1m0s
[09:41:15.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:111:0)
[09:41:15.312] Timer tick, asking Buildbucket for the build status
[09:41:15.466] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:15.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:112:0) after 1m0s
[09:42:15.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:112:0)
[09:42:15.480] Timer tick, asking Buildbucket for the build status
[09:42:15.682] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:15.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:113:0) after 1m0s
[09:43:16.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:113:0)
[09:43:16.833] Timer tick, asking Buildbucket for the build status
[09:43:16.897] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:16.897] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:114:0) after 1m0s
[09:44:17.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:114:0)
[09:44:17.824] Timer tick, asking Buildbucket for the build status
[09:44:18.265] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:18.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:115:0) after 1m0s
[09:45:18.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:115:0)
[09:45:18.326] Timer tick, asking Buildbucket for the build status
[09:45:18.454] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:18.454] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:116:0) after 1m0s
[09:46:18.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:116:0)
[09:46:18.547] Timer tick, asking Buildbucket for the build status
[09:46:18.752] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:18.753] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:117:0) after 1m0s
[09:47:18.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:117:0)
[09:47:18.798] Timer tick, asking Buildbucket for the build status
[09:47:18.938] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:18.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:118:0) after 1m0s
[09:48:18.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:118:0)
[09:48:18.960] Timer tick, asking Buildbucket for the build status
[09:48:20.199] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:20.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:119:0) after 1m0s
[09:49:20.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:119:0)
[09:49:20.230] Timer tick, asking Buildbucket for the build status
[09:49:20.312] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:20.312] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:120:0) after 1m0s
[09:50:20.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:120:0)
[09:50:20.418] Timer tick, asking Buildbucket for the build status
[09:50:20.506] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:20.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:121:0) after 1m0s
[09:51:20.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:121:0)
[09:51:20.560] Timer tick, asking Buildbucket for the build status
[09:51:20.715] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:20.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:122:0) after 1m0s
[09:52:20.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:122:0)
[09:52:20.782] Timer tick, asking Buildbucket for the build status
[09:52:20.890] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:20.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:123:0) after 1m0s
[09:53:20.870] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:123:0)
[09:53:20.870] Timer tick, asking Buildbucket for the build status
[09:53:20.966] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:20.966] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:124:0) after 1m0s
[09:54:21.060] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:124:0)
[09:54:21.060] Timer tick, asking Buildbucket for the build status
[09:54:21.137] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:21.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:125:0) after 1m0s
[09:55:21.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:125:0)
[09:55:21.119] Timer tick, asking Buildbucket for the build status
[09:55:21.426] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:21.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:126:0) after 1m0s
[09:56:21.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:126:0)
[09:56:21.465] Timer tick, asking Buildbucket for the build status
[09:56:21.734] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:21.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:127:0) after 1m0s
[09:57:21.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:127:0)
[09:57:21.750] Timer tick, asking Buildbucket for the build status
[09:57:22.452] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:22.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:128:0) after 1m0s
[09:58:22.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:128:0)
[09:58:22.481] Timer tick, asking Buildbucket for the build status
[09:58:22.584] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:22.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:129:0) after 1m0s
[09:59:22.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:129:0)
[09:59:22.610] Timer tick, asking Buildbucket for the build status
[09:59:22.683] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:22.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:130:0) after 1m0s
[10:00:22.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:130:0)
[10:00:22.707] Timer tick, asking Buildbucket for the build status
[10:00:25.817] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:25.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:131:0) after 1m0s
[10:01:25.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:131:0)
[10:01:25.851] Timer tick, asking Buildbucket for the build status
[10:01:25.967] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:25.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:132:0) after 1m0s
[10:02:25.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:132:0)
[10:02:25.960] Timer tick, asking Buildbucket for the build status
[10:02:26.249] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:26.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:133:0) after 1m0s
[10:03:26.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:133:0)
[10:03:26.285] Timer tick, asking Buildbucket for the build status
[10:03:26.358] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:26.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:134:0) after 1m0s
[10:04:26.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:134:0)
[10:04:26.398] Timer tick, asking Buildbucket for the build status
[10:04:26.494] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:26.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:135:0) after 1m0s
[10:05:26.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:135:0)
[10:05:26.488] Timer tick, asking Buildbucket for the build status
[10:05:26.561] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:26.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:136:0) after 1m0s
[10:06:26.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:136:0)
[10:06:26.684] Timer tick, asking Buildbucket for the build status
[10:06:26.747] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:26.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:137:0) after 1m0s
[10:07:26.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:137:0)
[10:07:26.806] Timer tick, asking Buildbucket for the build status
[10:07:26.921] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:26.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:138:0) after 1m0s
[10:08:27.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:138:0)
[10:08:27.024] Timer tick, asking Buildbucket for the build status
[10:08:27.130] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:27.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:139:0) after 1m0s
[10:09:27.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:139:0)
[10:09:27.252] Timer tick, asking Buildbucket for the build status
[10:09:27.320] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:27.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:140:0) after 1m0s
[10:10:27.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:140:0)
[10:10:27.350] Timer tick, asking Buildbucket for the build status
[10:10:27.409] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:27.409] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:141:0) after 1m0s
[10:11:27.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:141:0)
[10:11:27.397] Timer tick, asking Buildbucket for the build status
[10:11:27.463] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:27.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:142:0) after 1m0s
[10:12:27.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:142:0)
[10:12:27.483] Timer tick, asking Buildbucket for the build status
[10:12:27.567] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:27.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:143:0) after 1m0s
[10:13:27.586] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:143:0)
[10:13:27.586] Timer tick, asking Buildbucket for the build status
[10:13:27.651] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:27.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:144:0) after 1m0s
[10:14:27.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:144:0)
[10:14:27.676] Timer tick, asking Buildbucket for the build status
[10:14:27.737] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:27.737] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:145:0) after 1m0s
[10:15:27.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:145:0)
[10:15:27.771] Timer tick, asking Buildbucket for the build status
[10:15:27.838] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:27.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:146:0) after 1m0s
[10:16:28.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:146:0)
[10:16:28.105] Timer tick, asking Buildbucket for the build status
[10:16:28.244] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:28.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:147:0) after 1m0s
[10:17:28.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:147:0)
[10:17:28.322] Timer tick, asking Buildbucket for the build status
[10:17:28.439] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:28.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:148:0) after 1m0s
[10:18:28.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:148:0)
[10:18:28.461] Timer tick, asking Buildbucket for the build status
[10:18:28.729] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:28.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:149:0) after 1m0s
[10:19:28.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:149:0)
[10:19:28.778] Timer tick, asking Buildbucket for the build status
[10:19:29.277] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:29.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:150:0) after 1m0s
[10:20:29.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:150:0)
[10:20:29.355] Timer tick, asking Buildbucket for the build status
[10:20:29.538] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:29.539] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:151:0) after 1m0s
[10:21:29.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:151:0)
[10:21:29.572] Timer tick, asking Buildbucket for the build status
[10:21:29.634] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:29.634] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:152:0) after 1m0s
[10:22:29.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:152:0)
[10:22:29.642] Timer tick, asking Buildbucket for the build status
[10:22:29.738] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:29.738] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:153:0) after 1m0s
[10:23:30.258] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:153:0)
[10:23:30.258] Timer tick, asking Buildbucket for the build status
[10:23:30.336] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:30.336] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:154:0) after 1m0s
[10:24:30.685] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:154:0)
[10:24:30.685] Timer tick, asking Buildbucket for the build status
[10:24:33.105] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:33.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:155:0) after 1m0s
[10:25:33.567] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:155:0)
[10:25:33.567] Timer tick, asking Buildbucket for the build status
[10:25:33.747] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:33.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:156:0) after 1m0s
[10:26:33.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:156:0)
[10:26:33.822] Timer tick, asking Buildbucket for the build status
[10:26:34.123] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:34.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:157:0) after 1m0s
[10:27:34.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:157:0)
[10:27:34.210] Timer tick, asking Buildbucket for the build status
[10:27:34.625] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:34.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:158:0) after 1m0s
[10:28:34.689] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:158:0)
[10:28:34.689] Timer tick, asking Buildbucket for the build status
[10:28:34.762] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:34.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:159:0) after 1m0s
[10:29:34.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:159:0)
[10:29:34.786] Timer tick, asking Buildbucket for the build status
[10:29:35.058] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:35.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:160:0) after 1m0s
[10:30:35.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:160:0)
[10:30:35.285] Timer tick, asking Buildbucket for the build status
[10:30:35.531] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:35.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:161:0) after 1m0s
[10:31:35.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:161:0)
[10:31:35.535] Timer tick, asking Buildbucket for the build status
[10:31:35.637] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:35.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:162:0) after 1m0s
[10:32:35.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:162:0)
[10:32:35.764] Timer tick, asking Buildbucket for the build status
[10:32:35.856] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:35.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:163:0) after 1m0s
[10:33:35.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:163:0)
[10:33:35.906] Timer tick, asking Buildbucket for the build status
[10:33:35.977] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:35.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:164:0) after 1m0s
[10:34:36.188] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:164:0)
[10:34:36.188] Timer tick, asking Buildbucket for the build status
[10:34:36.287] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:36.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:165:0) after 1m0s
[10:35:36.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:165:0)
[10:35:36.391] Timer tick, asking Buildbucket for the build status
[10:35:36.674] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:36.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:166:0) after 1m0s
[10:36:36.757] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:166:0)
[10:36:36.757] Timer tick, asking Buildbucket for the build status
[10:36:37.223] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:37.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:167:0) after 1m0s
[10:37:37.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:167:0)
[10:37:37.238] Timer tick, asking Buildbucket for the build status
[10:37:37.805] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:37.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:168:0) after 1m0s
[10:38:37.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:168:0)
[10:38:37.900] Timer tick, asking Buildbucket for the build status
[10:38:38.185] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:38.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:169:0) after 1m0s
[10:39:38.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:169:0)
[10:39:38.164] Timer tick, asking Buildbucket for the build status
[10:39:38.240] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:38.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:170:0) after 1m0s
[10:40:38.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:170:0)
[10:40:38.264] Timer tick, asking Buildbucket for the build status
[10:40:38.349] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:38.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:171:0) after 1m0s
[10:41:38.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:171:0)
[10:41:38.418] Timer tick, asking Buildbucket for the build status
[10:41:38.483] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:38.483] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:172:0) after 1m0s
[10:42:38.575] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:172:0)
[10:42:38.575] Timer tick, asking Buildbucket for the build status
[10:42:39.020] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:39.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:173:0) after 1m0s
[10:43:39.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:173:0)
[10:43:39.186] Timer tick, asking Buildbucket for the build status
[10:43:39.260] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:39.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:174:0) after 1m0s
[10:44:39.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:174:0)
[10:44:39.381] Timer tick, asking Buildbucket for the build status
[10:44:39.490] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:39.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:175:0) after 1m0s
[10:45:39.744] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:175:0)
[10:45:39.744] Timer tick, asking Buildbucket for the build status
[10:45:39.836] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:39.836] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:176:0) after 1m0s
[10:46:39.889] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:176:0)
[10:46:39.889] Timer tick, asking Buildbucket for the build status
[10:46:39.972] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:39.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:177:0) after 1m0s
[10:47:40.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:177:0)
[10:47:40.092] Timer tick, asking Buildbucket for the build status
[10:47:40.373] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:40.373] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:178:0) after 1m0s
[10:48:40.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:178:0)
[10:48:40.484] Timer tick, asking Buildbucket for the build status
[10:48:40.549] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:40.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:179:0) after 1m0s
[10:49:40.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:179:0)
[10:49:40.620] Timer tick, asking Buildbucket for the build status
[10:49:40.691] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:40.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:180:0) after 1m0s
[10:50:40.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:180:0)
[10:50:40.736] Timer tick, asking Buildbucket for the build status
[10:50:40.823] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:40.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:181:0) after 1m0s
[10:51:40.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:181:0)
[10:51:40.848] Timer tick, asking Buildbucket for the build status
[10:51:40.938] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:40.938] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:182:0) after 1m0s
[10:52:40.968] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:182:0)
[10:52:40.968] Timer tick, asking Buildbucket for the build status
[10:52:41.133] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:41.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:183:0) after 1m0s
[10:53:41.233] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:183:0)
[10:53:41.233] Timer tick, asking Buildbucket for the build status
[10:53:41.308] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:41.308] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:184:0) after 1m0s
[10:54:41.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:184:0)
[10:54:41.333] Timer tick, asking Buildbucket for the build status
[10:54:41.400] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:41.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:185:0) after 1m0s
[10:55:41.494] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:185:0)
[10:55:41.494] Timer tick, asking Buildbucket for the build status
[10:55:41.582] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:41.582] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:186:0) after 1m0s
[10:56:41.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:186:0)
[10:56:41.653] Timer tick, asking Buildbucket for the build status
[10:56:41.905] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:41.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:187:0) after 1m0s
[10:57:41.960] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:187:0)
[10:57:41.960] Timer tick, asking Buildbucket for the build status
[10:57:42.074] Build 8853706741952809152: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:42.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9019136804012049856:188:0) after 1m0s
[10:58:32.359] Received PubSub notification, asking Buildbucket for the build status
[10:58:32.442] Build 8853706741952809152: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:58:32.442] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1614855511834418",
"created_by": "project:infra",
"created_ts": "1614844297414014",
"id": "8853706741952809152",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"89.0.4389.76\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"a78ed0e3-a7d9-4651-98e3-216842b771e2\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"89.0.4389.76\"}}",
"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-l5oj\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614844325117144",
"status": "COMPLETED",
"status_changed_ts": "1614844325760703",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9019136804012049856",
"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/8853706741952809152/+/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:52150a0c3a782610",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1614855511834766",
"url": "https://ci.chromium.org/b/8853706741952809152",
"utcnow_ts": "1614855512430394"
}
}
[10:58:32.442] Invocation finished in 3h6m56.375214993s with status SUCCEEDED