[08:10:01.741] New invocation is queued and will start shortly
[08:10:01.741] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[08:10:06.358] Starting the invocation (attempt 1)
[08:10:06.398] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:10:06.398] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:10:06.398] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9039610559057732240",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"86.0.4208.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"35c9e32c-a143-40d7-ab7c-cad547bcc185\",\"title\":\"publish_tarball/0\"}]},\"version\":\"86.0.4208.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9039610559057732240",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[08:10:07.191] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:infra",
"created_ts": "1595319006532927",
"id": "8874180493365373984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4208.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"35c9e32c-a143-40d7-ab7c-cad547bcc185\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4208.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1595319006987470",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9039610559057732240",
"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/8874180493365373984/+/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": "1595319006987634",
"url": "https://ci.chromium.org/b/8874180493365373984",
"utcnow_ts": "1595319007182192"
}
}
[08:10:07.191] Task URL: https://ci.chromium.org/b/8874180493365373984
[08:10:07.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:2:0) after 1m0s
[08:10:37.786] Received PubSub notification, asking Buildbucket for the build status
[08:10:37.903] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:07.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:2:0)
[08:11:07.312] Timer tick, asking Buildbucket for the build status
[08:11:07.501] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:07.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:4:0) after 1m0s
[08:12:07.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:4:0)
[08:12:07.707] Timer tick, asking Buildbucket for the build status
[08:12:08.093] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:08.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:5:0) after 1m0s
[08:13:08.361] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:5:0)
[08:13:08.361] Timer tick, asking Buildbucket for the build status
[08:13:08.535] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:08.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:6:0) after 1m0s
[08:14:08.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:6:0)
[08:14:08.654] Timer tick, asking Buildbucket for the build status
[08:14:08.840] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:08.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:7:0) after 1m0s
[08:15:09.167] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:7:0)
[08:15:09.167] Timer tick, asking Buildbucket for the build status
[08:15:10.427] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:10.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:8:0) after 1m0s
[08:16:10.519] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:8:0)
[08:16:10.519] Timer tick, asking Buildbucket for the build status
[08:16:10.712] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:10.712] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:9:0) after 1m0s
[08:17:10.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:9:0)
[08:17:10.724] Timer tick, asking Buildbucket for the build status
[08:17:11.211] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:11.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:10:0) after 1m0s
[08:18:11.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:10:0)
[08:18:11.385] Timer tick, asking Buildbucket for the build status
[08:18:11.542] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:11.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:11:0) after 1m0s
[08:19:11.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:11:0)
[08:19:11.601] Timer tick, asking Buildbucket for the build status
[08:19:11.949] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:11.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:12:0) after 1m0s
[08:20:11.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:12:0)
[08:20:11.990] Timer tick, asking Buildbucket for the build status
[08:20:12.178] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:12.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:13:0) after 1m0s
[08:21:12.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:13:0)
[08:21:12.318] Timer tick, asking Buildbucket for the build status
[08:21:12.510] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:12.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:14:0) after 1m0s
[08:22:12.537] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:14:0)
[08:22:12.537] Timer tick, asking Buildbucket for the build status
[08:22:12.877] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:12.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:15:0) after 1m0s
[08:23:13.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:15:0)
[08:23:13.004] Timer tick, asking Buildbucket for the build status
[08:23:16.503] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:16.503] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:16:0) after 1m0s
[08:24:16.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:16:0)
[08:24:16.602] Timer tick, asking Buildbucket for the build status
[08:24:16.746] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:16.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:17:0) after 1m0s
[08:25:16.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:17:0)
[08:25:16.874] Timer tick, asking Buildbucket for the build status
[08:25:16.973] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:16.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:18:0) after 1m0s
[08:26:17.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:18:0)
[08:26:17.031] Timer tick, asking Buildbucket for the build status
[08:26:17.353] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:17.353] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:19:0) after 1m0s
[08:27:17.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:19:0)
[08:27:17.433] Timer tick, asking Buildbucket for the build status
[08:27:17.546] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:17.546] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:20:0) after 1m0s
[08:28:17.621] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:20:0)
[08:28:17.621] Timer tick, asking Buildbucket for the build status
[08:28:17.829] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:17.829] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:21:0) after 1m0s
[08:29:17.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:21:0)
[08:29:17.893] Timer tick, asking Buildbucket for the build status
[08:29:18.042] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:18.042] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:22:0) after 1m0s
[08:30:18.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:22:0)
[08:30:18.271] Timer tick, asking Buildbucket for the build status
[08:30:18.742] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:18.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:23:0) after 1m0s
[08:31:18.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:23:0)
[08:31:18.862] Timer tick, asking Buildbucket for the build status
[08:31:20.005] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:20.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:24:0) after 1m0s
[08:32:20.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:24:0)
[08:32:20.304] Timer tick, asking Buildbucket for the build status
[08:32:20.671] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:20.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:25:0) after 1m0s
[08:33:20.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:25:0)
[08:33:20.813] Timer tick, asking Buildbucket for the build status
[08:33:20.989] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:20.989] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:26:0) after 1m0s
[08:34:21.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:26:0)
[08:34:21.145] Timer tick, asking Buildbucket for the build status
[08:34:21.486] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:21.486] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:27:0) after 1m0s
[08:35:21.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:27:0)
[08:35:21.674] Timer tick, asking Buildbucket for the build status
[08:35:21.859] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:21.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:28:0) after 1m0s
[08:36:21.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:28:0)
[08:36:21.921] Timer tick, asking Buildbucket for the build status
[08:36:22.239] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:22.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:29:0) after 1m0s
[08:37:22.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:29:0)
[08:37:22.264] Timer tick, asking Buildbucket for the build status
[08:37:22.925] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:22.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:30:0) after 1m0s
[08:38:24.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:30:0)
[08:38:24.411] Timer tick, asking Buildbucket for the build status
[08:38:24.686] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:24.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:31:0) after 1m0s
[08:39:24.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:31:0)
[08:39:24.853] Timer tick, asking Buildbucket for the build status
[08:39:25.123] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:25.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:32:0) after 1m0s
[08:40:25.286] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:32:0)
[08:40:25.286] Timer tick, asking Buildbucket for the build status
[08:40:25.452] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:25.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:33:0) after 1m0s
[08:41:25.490] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:33:0)
[08:41:25.490] Timer tick, asking Buildbucket for the build status
[08:41:25.834] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:25.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:34:0) after 1m0s
[08:42:25.943] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:34:0)
[08:42:25.943] Timer tick, asking Buildbucket for the build status
[08:42:26.372] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:26.372] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:35:0) after 1m0s
[08:43:26.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:35:0)
[08:43:26.414] Timer tick, asking Buildbucket for the build status
[08:43:26.921] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:26.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:36:0) after 1m0s
[08:44:27.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:36:0)
[08:44:27.001] Timer tick, asking Buildbucket for the build status
[08:44:27.193] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:27.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:37:0) after 1m0s
[08:45:27.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:37:0)
[08:45:27.482] Timer tick, asking Buildbucket for the build status
[08:45:27.744] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:27.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:38:0) after 1m0s
[08:46:27.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:38:0)
[08:46:27.893] Timer tick, asking Buildbucket for the build status
[08:46:28.416] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:28.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:39:0) after 1m0s
[08:47:28.562] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:39:0)
[08:47:28.562] Timer tick, asking Buildbucket for the build status
[08:47:29.075] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:29.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:40:0) after 1m0s
[08:48:29.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:40:0)
[08:48:29.210] Timer tick, asking Buildbucket for the build status
[08:48:32.425] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:32.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:41:0) after 1m0s
[08:49:32.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:41:0)
[08:49:32.459] Timer tick, asking Buildbucket for the build status
[08:49:32.674] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:32.674] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:42:0) after 1m0s
[08:50:32.786] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:42:0)
[08:50:32.786] Timer tick, asking Buildbucket for the build status
[08:50:32.909] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:32.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:43:0) after 1m0s
[08:51:32.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:43:0)
[08:51:32.992] Timer tick, asking Buildbucket for the build status
[08:51:33.370] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:33.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:44:0) after 1m0s
[08:52:33.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:44:0)
[08:52:33.391] Timer tick, asking Buildbucket for the build status
[08:52:33.707] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:33.707] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:45:0) after 1m0s
[08:53:33.720] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:45:0)
[08:53:33.720] Timer tick, asking Buildbucket for the build status
[08:53:33.982] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:33.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:46:0) after 1m0s
[08:54:34.011] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:46:0)
[08:54:34.011] Timer tick, asking Buildbucket for the build status
[08:54:34.122] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:34.122] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:47:0) after 1m0s
[08:55:34.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:47:0)
[08:55:34.141] Timer tick, asking Buildbucket for the build status
[08:55:34.351] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:34.351] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:48:0) after 1m0s
[08:56:34.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:48:0)
[08:56:34.414] Timer tick, asking Buildbucket for the build status
[08:56:34.801] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:34.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:49:0) after 1m0s
[08:57:34.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:49:0)
[08:57:34.800] Timer tick, asking Buildbucket for the build status
[08:57:35.010] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:35.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:50:0) after 1m0s
[08:58:35.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:50:0)
[08:58:35.029] Timer tick, asking Buildbucket for the build status
[08:58:36.939] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:36.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:51:0) after 1m0s
[08:59:36.989] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:51:0)
[08:59:36.989] Timer tick, asking Buildbucket for the build status
[08:59:37.485] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:37.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:52:0) after 1m0s
[09:00:37.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:52:0)
[09:00:37.509] Timer tick, asking Buildbucket for the build status
[09:00:39.124] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:39.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:53:0) after 1m0s
[09:01:39.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:53:0)
[09:01:39.195] Timer tick, asking Buildbucket for the build status
[09:01:39.524] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:39.524] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:54:0) after 1m0s
[09:02:39.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:54:0)
[09:02:39.555] Timer tick, asking Buildbucket for the build status
[09:02:39.671] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:39.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:55:0) after 1m0s
[09:03:39.696] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:55:0)
[09:03:39.696] Timer tick, asking Buildbucket for the build status
[09:03:39.884] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:39.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:56:0) after 1m0s
[09:04:39.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:56:0)
[09:04:39.886] Timer tick, asking Buildbucket for the build status
[09:04:40.909] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:40.909] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:57:0) after 1m0s
[09:05:40.964] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:57:0)
[09:05:40.964] Timer tick, asking Buildbucket for the build status
[09:05:42.516] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:42.517] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:58:0) after 1m0s
[09:06:42.676] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:58:0)
[09:06:42.676] Timer tick, asking Buildbucket for the build status
[09:06:42.984] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:42.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:59:0) after 1m0s
[09:07:43.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:59:0)
[09:07:43.078] Timer tick, asking Buildbucket for the build status
[09:07:43.392] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:43.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:60:0) after 1m0s
[09:08:43.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:60:0)
[09:08:43.422] Timer tick, asking Buildbucket for the build status
[09:08:43.879] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:43.879] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:61:0) after 1m0s
[09:09:43.959] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:61:0)
[09:09:43.959] Timer tick, asking Buildbucket for the build status
[09:09:44.297] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:44.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:62:0) after 1m0s
[09:10:44.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:62:0)
[09:10:44.376] Timer tick, asking Buildbucket for the build status
[09:10:47.302] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:47.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:63:0) after 1m0s
[09:11:47.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:63:0)
[09:11:47.328] Timer tick, asking Buildbucket for the build status
[09:11:47.872] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:47.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:64:0) after 1m0s
[09:12:47.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:64:0)
[09:12:47.887] Timer tick, asking Buildbucket for the build status
[09:12:48.045] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:48.045] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:65:0) after 1m0s
[09:13:48.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:65:0)
[09:13:48.064] Timer tick, asking Buildbucket for the build status
[09:13:48.518] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:48.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:66:0) after 1m0s
[09:14:48.616] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:66:0)
[09:14:48.616] Timer tick, asking Buildbucket for the build status
[09:14:49.741] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:49.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:67:0) after 1m0s
[09:15:49.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:67:0)
[09:15:49.731] Timer tick, asking Buildbucket for the build status
[09:15:49.848] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:49.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:68:0) after 1m0s
[09:16:49.998] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:68:0)
[09:16:49.998] Timer tick, asking Buildbucket for the build status
[09:16:50.181] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:50.181] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:69:0) after 1m0s
[09:17:50.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:69:0)
[09:17:50.210] Timer tick, asking Buildbucket for the build status
[09:17:50.430] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:50.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:70:0) after 1m0s
[09:18:50.504] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:70:0)
[09:18:50.504] Timer tick, asking Buildbucket for the build status
[09:18:51.361] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:51.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:71:0) after 1m0s
[09:19:51.334] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:71:0)
[09:19:51.334] Timer tick, asking Buildbucket for the build status
[09:19:51.519] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:51.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:72:0) after 1m0s
[09:20:51.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:72:0)
[09:20:51.579] Timer tick, asking Buildbucket for the build status
[09:20:51.773] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:51.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:73:0) after 1m0s
[09:21:51.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:73:0)
[09:21:51.810] Timer tick, asking Buildbucket for the build status
[09:21:52.260] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:52.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:74:0) after 1m0s
[09:22:52.284] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:74:0)
[09:22:52.284] Timer tick, asking Buildbucket for the build status
[09:22:53.157] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:53.157] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:75:0) after 1m0s
[09:23:53.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:75:0)
[09:23:53.243] Timer tick, asking Buildbucket for the build status
[09:23:53.450] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:53.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:76:0) after 1m0s
[09:24:53.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:76:0)
[09:24:53.506] Timer tick, asking Buildbucket for the build status
[09:24:53.798] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:53.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:77:0) after 1m0s
[09:25:53.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:77:0)
[09:25:53.821] Timer tick, asking Buildbucket for the build status
[09:25:54.448] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:54.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:78:0) after 1m0s
[09:26:54.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:78:0)
[09:26:54.468] Timer tick, asking Buildbucket for the build status
[09:26:54.759] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:54.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:79:0) after 1m0s
[09:27:54.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:79:0)
[09:27:54.856] Timer tick, asking Buildbucket for the build status
[09:27:55.363] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:55.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:80:0) after 1m0s
[09:28:55.391] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:80:0)
[09:28:55.391] Timer tick, asking Buildbucket for the build status
[09:28:55.855] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:55.855] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:81:0) after 1m0s
[09:29:55.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:81:0)
[09:29:55.886] Timer tick, asking Buildbucket for the build status
[09:29:56.145] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:56.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:82:0) after 1m0s
[09:30:56.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:82:0)
[09:30:56.350] Timer tick, asking Buildbucket for the build status
[09:30:56.581] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:56.581] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:83:0) after 1m0s
[09:31:56.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:83:0)
[09:31:56.634] Timer tick, asking Buildbucket for the build status
[09:31:56.943] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:56.943] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:84:0) after 1m0s
[09:32:57.080] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:84:0)
[09:32:57.080] Timer tick, asking Buildbucket for the build status
[09:32:57.959] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:57.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:85:0) after 1m0s
[09:33:57.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:85:0)
[09:33:57.981] Timer tick, asking Buildbucket for the build status
[09:33:58.083] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:58.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:86:0) after 1m0s
[09:34:58.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:86:0)
[09:34:58.153] Timer tick, asking Buildbucket for the build status
[09:34:58.949] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:58.949] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:87:0) after 1m0s
[09:35:59.012] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:87:0)
[09:35:59.012] Timer tick, asking Buildbucket for the build status
[09:35:59.159] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:59.160] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:88:0) after 1m0s
[09:36:59.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:88:0)
[09:36:59.216] Timer tick, asking Buildbucket for the build status
[09:36:59.479] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:59.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:89:0) after 1m0s
[09:37:59.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:89:0)
[09:37:59.510] Timer tick, asking Buildbucket for the build status
[09:38:06.812] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:06.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:90:0) after 1m0s
[09:39:06.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:90:0)
[09:39:06.815] Timer tick, asking Buildbucket for the build status
[09:39:07.640] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:07.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:91:0) after 1m0s
[09:40:07.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:91:0)
[09:40:07.666] Timer tick, asking Buildbucket for the build status
[09:40:08.109] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:08.109] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:92:0) after 1m0s
[09:41:08.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:92:0)
[09:41:08.151] Timer tick, asking Buildbucket for the build status
[09:41:08.327] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:08.327] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:93:0) after 1m0s
[09:42:08.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:93:0)
[09:42:08.374] Timer tick, asking Buildbucket for the build status
[09:42:09.541] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:94:0) after 1m0s
[09:43:09.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:94:0)
[09:43:09.570] Timer tick, asking Buildbucket for the build status
[09:43:10.173] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:10.173] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:95:0) after 1m0s
[09:44:10.228] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:95:0)
[09:44:10.228] Timer tick, asking Buildbucket for the build status
[09:44:10.832] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:10.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:96:0) after 1m0s
[09:45:10.925] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:96:0)
[09:45:10.925] Timer tick, asking Buildbucket for the build status
[09:45:11.108] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:11.108] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:97:0) after 1m0s
[09:46:11.175] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:97:0)
[09:46:11.175] Timer tick, asking Buildbucket for the build status
[09:46:11.602] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:11.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:98:0) after 1m0s
[09:47:11.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:98:0)
[09:47:11.601] Timer tick, asking Buildbucket for the build status
[09:47:12.039] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:12.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:99:0) after 1m0s
[09:48:12.106] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:99:0)
[09:48:12.106] Timer tick, asking Buildbucket for the build status
[09:48:12.688] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:12.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:100:0) after 1m0s
[09:49:12.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:100:0)
[09:49:12.839] Timer tick, asking Buildbucket for the build status
[09:49:15.079] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:15.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:101:0) after 1m0s
[09:50:15.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:101:0)
[09:50:15.145] Timer tick, asking Buildbucket for the build status
[09:50:15.632] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:15.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:102:0) after 1m0s
[09:51:15.819] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:102:0)
[09:51:15.819] Timer tick, asking Buildbucket for the build status
[09:51:16.225] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:16.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:103:0) after 1m0s
[09:52:16.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:103:0)
[09:52:16.389] Timer tick, asking Buildbucket for the build status
[09:52:16.559] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:16.559] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:104:0) after 1m0s
[09:53:16.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:104:0)
[09:53:16.707] Timer tick, asking Buildbucket for the build status
[09:53:17.138] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:17.138] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:105:0) after 1m0s
[09:54:17.163] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:105:0)
[09:54:17.163] Timer tick, asking Buildbucket for the build status
[09:54:17.417] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:17.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:106:0) after 1m0s
[09:55:17.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:106:0)
[09:55:17.428] Timer tick, asking Buildbucket for the build status
[09:55:18.392] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:18.392] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:107:0) after 1m0s
[09:56:18.432] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:107:0)
[09:56:18.432] Timer tick, asking Buildbucket for the build status
[09:56:18.778] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:18.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:108:0) after 1m0s
[09:57:19.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:108:0)
[09:57:19.327] Timer tick, asking Buildbucket for the build status
[09:57:19.534] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:19.534] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:109:0) after 1m0s
[09:58:19.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:109:0)
[09:58:19.528] Timer tick, asking Buildbucket for the build status
[09:58:19.661] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:19.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:110:0) after 1m0s
[09:59:19.719] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:110:0)
[09:59:19.719] Timer tick, asking Buildbucket for the build status
[09:59:19.961] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:19.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:111:0) after 1m0s
[10:00:20.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:111:0)
[10:00:20.107] Timer tick, asking Buildbucket for the build status
[10:00:22.264] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:22.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:112:0) after 1m0s
[10:01:22.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:112:0)
[10:01:22.383] Timer tick, asking Buildbucket for the build status
[10:01:22.609] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:22.609] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:113:0) after 1m0s
[10:02:22.641] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:113:0)
[10:02:22.641] Timer tick, asking Buildbucket for the build status
[10:02:22.778] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:22.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:114:0) after 1m0s
[10:03:22.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:114:0)
[10:03:22.874] Timer tick, asking Buildbucket for the build status
[10:03:23.021] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:23.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:115:0) after 1m0s
[10:04:23.227] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:115:0)
[10:04:23.227] Timer tick, asking Buildbucket for the build status
[10:04:23.393] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:23.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:116:0) after 1m0s
[10:05:23.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:116:0)
[10:05:23.512] Timer tick, asking Buildbucket for the build status
[10:05:23.702] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:23.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:117:0) after 1m0s
[10:06:23.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:117:0)
[10:06:23.867] Timer tick, asking Buildbucket for the build status
[10:06:24.130] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:24.130] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:118:0) after 1m0s
[10:07:24.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:118:0)
[10:07:24.301] Timer tick, asking Buildbucket for the build status
[10:07:24.768] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:24.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:119:0) after 1m0s
[10:08:24.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:119:0)
[10:08:24.898] Timer tick, asking Buildbucket for the build status
[10:08:25.152] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:25.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:120:0) after 1m0s
[10:09:25.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:120:0)
[10:09:25.249] Timer tick, asking Buildbucket for the build status
[10:09:25.423] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:25.423] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:121:0) after 1m0s
[10:10:25.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:121:0)
[10:10:25.582] Timer tick, asking Buildbucket for the build status
[10:10:28.613] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:28.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:122:0) after 1m0s
[10:11:28.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:122:0)
[10:11:28.684] Timer tick, asking Buildbucket for the build status
[10:11:29.036] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:29.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:123:0) after 1m0s
[10:12:29.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:123:0)
[10:12:29.089] Timer tick, asking Buildbucket for the build status
[10:12:29.435] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:29.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:124:0) after 1m0s
[10:13:29.534] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:124:0)
[10:13:29.534] Timer tick, asking Buildbucket for the build status
[10:13:29.810] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:29.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:125:0) after 1m0s
[10:14:29.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:125:0)
[10:14:29.827] Timer tick, asking Buildbucket for the build status
[10:14:30.073] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:30.073] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:126:0) after 1m0s
[10:15:30.219] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:126:0)
[10:15:30.219] Timer tick, asking Buildbucket for the build status
[10:15:30.698] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:30.698] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:127:0) after 1m0s
[10:16:30.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:127:0)
[10:16:30.751] Timer tick, asking Buildbucket for the build status
[10:16:30.872] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:30.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:128:0) after 1m0s
[10:17:30.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:128:0)
[10:17:30.955] Timer tick, asking Buildbucket for the build status
[10:17:31.468] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:31.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:129:0) after 1m0s
[10:18:31.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:129:0)
[10:18:31.514] Timer tick, asking Buildbucket for the build status
[10:18:32.141] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:32.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:130:0) after 1m0s
[10:19:32.217] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:130:0)
[10:19:32.217] Timer tick, asking Buildbucket for the build status
[10:19:32.354] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:32.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:131:0) after 1m0s
[10:20:32.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:131:0)
[10:20:32.376] Timer tick, asking Buildbucket for the build status
[10:20:33.104] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:33.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:132:0) after 1m0s
[10:21:33.178] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:132:0)
[10:21:33.178] Timer tick, asking Buildbucket for the build status
[10:21:33.398] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:33.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:133:0) after 1m0s
[10:22:33.442] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:133:0)
[10:22:33.442] Timer tick, asking Buildbucket for the build status
[10:22:33.651] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:33.651] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:134:0) after 1m0s
[10:23:34.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:134:0)
[10:23:34.397] Timer tick, asking Buildbucket for the build status
[10:23:34.627] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:34.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:135:0) after 1m0s
[10:24:34.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:135:0)
[10:24:34.732] Timer tick, asking Buildbucket for the build status
[10:24:34.973] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:34.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:136:0) after 1m0s
[10:25:34.993] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:136:0)
[10:25:34.993] Timer tick, asking Buildbucket for the build status
[10:25:35.140] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:35.140] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:137:0) after 1m0s
[10:26:35.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:137:0)
[10:26:35.251] Timer tick, asking Buildbucket for the build status
[10:26:35.450] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:35.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:138:0) after 1m0s
[10:27:35.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:138:0)
[10:27:35.477] Timer tick, asking Buildbucket for the build status
[10:27:35.823] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:35.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:139:0) after 1m0s
[10:28:35.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:139:0)
[10:28:35.852] Timer tick, asking Buildbucket for the build status
[10:28:39.075] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:39.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:140:0) after 1m0s
[10:29:39.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:140:0)
[10:29:39.085] Timer tick, asking Buildbucket for the build status
[10:29:39.492] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:39.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:141:0) after 1m0s
[10:30:39.516] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:141:0)
[10:30:39.516] Timer tick, asking Buildbucket for the build status
[10:30:39.877] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:39.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:142:0) after 1m0s
[10:31:39.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:142:0)
[10:31:39.905] Timer tick, asking Buildbucket for the build status
[10:31:40.214] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:40.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:143:0) after 1m0s
[10:32:40.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:143:0)
[10:32:40.285] Timer tick, asking Buildbucket for the build status
[10:32:40.381] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:40.381] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:144:0) after 1m0s
[10:33:40.525] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:144:0)
[10:33:40.525] Timer tick, asking Buildbucket for the build status
[10:33:42.155] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:42.155] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:145:0) after 1m0s
[10:34:42.285] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:145:0)
[10:34:42.285] Timer tick, asking Buildbucket for the build status
[10:34:42.730] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:42.730] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:146:0) after 1m0s
[10:35:42.766] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:146:0)
[10:35:42.766] Timer tick, asking Buildbucket for the build status
[10:35:43.028] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:43.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:147:0) after 1m0s
[10:36:43.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:147:0)
[10:36:43.135] Timer tick, asking Buildbucket for the build status
[10:36:43.311] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:43.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:148:0) after 1m0s
[10:37:43.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:148:0)
[10:37:43.407] Timer tick, asking Buildbucket for the build status
[10:37:43.592] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:43.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:149:0) after 1m0s
[10:38:43.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:149:0)
[10:38:43.662] Timer tick, asking Buildbucket for the build status
[10:38:44.253] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:44.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:150:0) after 1m0s
[10:39:44.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:150:0)
[10:39:44.312] Timer tick, asking Buildbucket for the build status
[10:39:44.529] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:44.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:151:0) after 1m0s
[10:40:44.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:151:0)
[10:40:44.606] Timer tick, asking Buildbucket for the build status
[10:40:44.716] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:44.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:152:0) after 1m0s
[10:41:44.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:152:0)
[10:41:44.803] Timer tick, asking Buildbucket for the build status
[10:41:44.972] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:44.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:153:0) after 1m0s
[10:42:45.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:153:0)
[10:42:45.035] Timer tick, asking Buildbucket for the build status
[10:42:45.177] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:45.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:154:0) after 1m0s
[10:43:45.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:154:0)
[10:43:45.257] Timer tick, asking Buildbucket for the build status
[10:43:45.414] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:45.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:155:0) after 1m0s
[10:44:45.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:155:0)
[10:44:45.488] Timer tick, asking Buildbucket for the build status
[10:44:45.652] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:45.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:156:0) after 1m0s
[10:45:45.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:156:0)
[10:45:45.712] Timer tick, asking Buildbucket for the build status
[10:45:45.831] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:45.831] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:157:0) after 1m0s
[10:46:45.906] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:157:0)
[10:46:45.906] Timer tick, asking Buildbucket for the build status
[10:46:46.065] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:46.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:158:0) after 1m0s
[10:47:46.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:158:0)
[10:47:46.166] Timer tick, asking Buildbucket for the build status
[10:47:46.450] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:46.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:159:0) after 1m0s
[10:48:46.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:159:0)
[10:48:46.508] Timer tick, asking Buildbucket for the build status
[10:48:46.666] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:46.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:160:0) after 1m0s
[10:49:46.683] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:160:0)
[10:49:46.683] Timer tick, asking Buildbucket for the build status
[10:49:46.822] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:46.822] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:161:0) after 1m0s
[10:50:46.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:161:0)
[10:50:46.827] Timer tick, asking Buildbucket for the build status
[10:50:47.012] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:47.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:162:0) after 1m0s
[10:51:47.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:162:0)
[10:51:47.239] Timer tick, asking Buildbucket for the build status
[10:51:47.375] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:47.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:163:0) after 1m0s
[10:52:47.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:163:0)
[10:52:47.403] Timer tick, asking Buildbucket for the build status
[10:52:47.567] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:47.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:164:0) after 1m0s
[10:53:47.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:164:0)
[10:53:47.593] Timer tick, asking Buildbucket for the build status
[10:53:47.694] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:47.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:165:0) after 1m0s
[10:54:48.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:165:0)
[10:54:48.751] Timer tick, asking Buildbucket for the build status
[10:54:48.927] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:48.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:166:0) after 1m0s
[10:55:49.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:166:0)
[10:55:49.179] Timer tick, asking Buildbucket for the build status
[10:55:50.397] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:50.397] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:167:0) after 1m0s
[10:56:50.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:167:0)
[10:56:50.461] Timer tick, asking Buildbucket for the build status
[10:56:50.624] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:50.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:168:0) after 1m0s
[10:57:50.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:168:0)
[10:57:50.679] Timer tick, asking Buildbucket for the build status
[10:57:50.857] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:50.858] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:169:0) after 1m0s
[10:58:50.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:169:0)
[10:58:50.916] Timer tick, asking Buildbucket for the build status
[10:58:51.046] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:51.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:170:0) after 1m0s
[10:59:51.092] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:170:0)
[10:59:51.092] Timer tick, asking Buildbucket for the build status
[10:59:51.295] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:51.295] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:171:0) after 1m0s
[11:00:51.379] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:171:0)
[11:00:51.379] Timer tick, asking Buildbucket for the build status
[11:00:52.493] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:52.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:172:0) after 1m0s
[11:01:52.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:172:0)
[11:01:52.566] Timer tick, asking Buildbucket for the build status
[11:01:56.093] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:56.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:173:0) after 1m0s
[11:02:56.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:173:0)
[11:02:56.096] Timer tick, asking Buildbucket for the build status
[11:02:56.192] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:56.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:174:0) after 1m0s
[11:03:56.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:174:0)
[11:03:56.232] Timer tick, asking Buildbucket for the build status
[11:03:56.361] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:56.361] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:175:0) after 1m0s
[11:04:56.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:175:0)
[11:04:56.438] Timer tick, asking Buildbucket for the build status
[11:04:56.550] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:56.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:176:0) after 1m0s
[11:05:56.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:176:0)
[11:05:56.553] Timer tick, asking Buildbucket for the build status
[11:05:56.890] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:56.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:177:0) after 1m0s
[11:06:56.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:177:0)
[11:06:56.940] Timer tick, asking Buildbucket for the build status
[11:06:57.092] Build 8874180493365373984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:57.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9039610559057732240:178:0) after 1m0s
[11:07:50.010] Received PubSub notification, asking Buildbucket for the build status
[11:07:50.093] Build 8874180493365373984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:07:50.093] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1595329668837538",
"created_by": "project:infra",
"created_ts": "1595319006532927",
"id": "8874180493365373984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"86.0.4208.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"35c9e32c-a143-40d7-ab7c-cad547bcc185\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"86.0.4208.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-0lj2\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5425-e4e3059\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1595319036786690",
"status": "COMPLETED",
"status_changed_ts": "1595329669621685",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9039610559057732240",
"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/8874180493365373984/+/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:4d893dc02704ef10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1595329669640845",
"url": "https://ci.chromium.org/b/8874180493365373984",
"utcnow_ts": "1595329670083956"
}
}
[11:07:50.093] Invocation finished in 2h57m48.374013344s with status SUCCEEDED