[23:22:48.588] New invocation is queued and will start shortly
[23:22:48.588] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[23:22:49.681] Starting the invocation (attempt 1)
[23:22:49.731] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:22:49.732] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:22:49.732] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9031399404878190912",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4296.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"37d8e3e3-11dc-4512-8306-a814fef91be9\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4296.4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9031399404878190912",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[23:22:50.302] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1603149769819677",
"id": "8865969342920887008",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4296.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"37d8e3e3-11dc-4512-8306-a814fef91be9\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4296.4\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603149770004540",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031399404878190912",
"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/8865969342920887008/+/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": "1603149770004657",
"url": "https://ci.chromium.org/b/8865969342920887008",
"utcnow_ts": "1603149770287459"
}
}
[23:22:50.302] Task URL: https://ci.chromium.org/b/8865969342920887008
[23:22:50.302] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:2:0) after 1m0s
[23:23:15.157] Received PubSub notification, asking Buildbucket for the build status
[23:23:15.603] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:50.300] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:2:0)
[23:23:50.300] Timer tick, asking Buildbucket for the build status
[23:23:50.419] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:50.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:4:0) after 1m0s
[23:24:50.492] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:4:0)
[23:24:50.492] Timer tick, asking Buildbucket for the build status
[23:24:50.622] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:50.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:5:0) after 1m0s
[23:25:50.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:5:0)
[23:25:50.705] Timer tick, asking Buildbucket for the build status
[23:25:51.004] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:51.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:6:0) after 1m0s
[23:26:51.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:6:0)
[23:26:51.052] Timer tick, asking Buildbucket for the build status
[23:26:51.118] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:51.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:7:0) after 1m0s
[23:27:51.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:7:0)
[23:27:51.121] Timer tick, asking Buildbucket for the build status
[23:27:51.244] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:51.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:8:0) after 1m0s
[23:28:51.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:8:0)
[23:28:51.261] Timer tick, asking Buildbucket for the build status
[23:28:51.324] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:51.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:9:0) after 1m0s
[23:29:51.422] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:9:0)
[23:29:51.422] Timer tick, asking Buildbucket for the build status
[23:29:51.606] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:51.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:10:0) after 1m0s
[23:30:51.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:10:0)
[23:30:51.739] Timer tick, asking Buildbucket for the build status
[23:30:51.825] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:51.825] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:11:0) after 1m0s
[23:31:51.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:11:0)
[23:31:51.831] Timer tick, asking Buildbucket for the build status
[23:31:51.891] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:51.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:12:0) after 1m0s
[23:32:51.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:12:0)
[23:32:51.938] Timer tick, asking Buildbucket for the build status
[23:32:52.282] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:52.282] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:13:0) after 1m0s
[23:33:52.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:13:0)
[23:33:52.385] Timer tick, asking Buildbucket for the build status
[23:33:52.460] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:52.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:14:0) after 1m0s
[23:34:52.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:14:0)
[23:34:52.523] Timer tick, asking Buildbucket for the build status
[23:34:52.781] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:52.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:15:0) after 1m0s
[23:35:52.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:15:0)
[23:35:52.863] Timer tick, asking Buildbucket for the build status
[23:35:53.075] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:53.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:16:0) after 1m0s
[23:36:53.078] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:16:0)
[23:36:53.078] Timer tick, asking Buildbucket for the build status
[23:36:53.147] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:53.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:17:0) after 1m0s
[23:37:53.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:17:0)
[23:37:53.281] Timer tick, asking Buildbucket for the build status
[23:37:53.388] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:53.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:18:0) after 1m0s
[23:38:53.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:18:0)
[23:38:53.762] Timer tick, asking Buildbucket for the build status
[23:38:53.925] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:53.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:19:0) after 1m0s
[23:39:54.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:19:0)
[23:39:54.109] Timer tick, asking Buildbucket for the build status
[23:39:54.165] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:54.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:20:0) after 1m0s
[23:40:54.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:20:0)
[23:40:54.313] Timer tick, asking Buildbucket for the build status
[23:40:54.388] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:54.388] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:21:0) after 1m0s
[23:41:54.568] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:21:0)
[23:41:54.568] Timer tick, asking Buildbucket for the build status
[23:41:54.641] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:54.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:22:0) after 1m0s
[23:42:54.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:22:0)
[23:42:54.681] Timer tick, asking Buildbucket for the build status
[23:42:54.796] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:54.796] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:23:0) after 1m0s
[23:43:54.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:23:0)
[23:43:54.932] Timer tick, asking Buildbucket for the build status
[23:43:54.993] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:54.993] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:24:0) after 1m0s
[23:44:55.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:24:0)
[23:44:55.105] Timer tick, asking Buildbucket for the build status
[23:44:55.176] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:55.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:25:0) after 1m0s
[23:45:55.215] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:25:0)
[23:45:55.215] Timer tick, asking Buildbucket for the build status
[23:45:55.335] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:55.335] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:26:0) after 1m0s
[23:46:55.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:26:0)
[23:46:55.355] Timer tick, asking Buildbucket for the build status
[23:46:55.489] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:55.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:27:0) after 1m0s
[23:47:55.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:27:0)
[23:47:55.589] Timer tick, asking Buildbucket for the build status
[23:47:55.697] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:55.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:28:0) after 1m0s
[23:48:56.254] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:28:0)
[23:48:56.255] Timer tick, asking Buildbucket for the build status
[23:48:56.472] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:56.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:29:0) after 1m0s
[23:49:56.592] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:29:0)
[23:49:56.592] Timer tick, asking Buildbucket for the build status
[23:49:56.784] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:56.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:30:0) after 1m0s
[23:50:56.831] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:30:0)
[23:50:56.831] Timer tick, asking Buildbucket for the build status
[23:50:57.116] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:57.116] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:31:0) after 1m0s
[23:51:57.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:31:0)
[23:51:57.132] Timer tick, asking Buildbucket for the build status
[23:51:57.194] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:57.194] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:32:0) after 1m0s
[23:52:57.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:32:0)
[23:52:57.287] Timer tick, asking Buildbucket for the build status
[23:52:57.384] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:57.384] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:33:0) after 1m0s
[23:53:57.423] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:33:0)
[23:53:57.423] Timer tick, asking Buildbucket for the build status
[23:53:57.512] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:57.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:34:0) after 1m0s
[23:54:57.559] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:34:0)
[23:54:57.559] Timer tick, asking Buildbucket for the build status
[23:54:57.769] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:57.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:35:0) after 1m0s
[23:55:57.805] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:35:0)
[23:55:57.805] Timer tick, asking Buildbucket for the build status
[23:55:57.878] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:57.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:36:0) after 1m0s
[23:56:57.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:36:0)
[23:56:57.913] Timer tick, asking Buildbucket for the build status
[23:56:59.705] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:59.705] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:37:0) after 1m0s
[23:57:59.714] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:37:0)
[23:57:59.714] Timer tick, asking Buildbucket for the build status
[23:57:59.850] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:59.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:38:0) after 1m0s
[23:58:59.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:38:0)
[23:58:59.897] Timer tick, asking Buildbucket for the build status
[23:58:59.959] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:59.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:39:0) after 1m0s
[00:00:00.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:39:0)
[00:00:00.003] Timer tick, asking Buildbucket for the build status
[00:00:00.267] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:00.267] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:40:0) after 1m0s
[00:01:00.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:40:0)
[00:01:00.324] Timer tick, asking Buildbucket for the build status
[00:01:00.402] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:00.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:41:0) after 1m0s
[00:02:00.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:41:0)
[00:02:00.419] Timer tick, asking Buildbucket for the build status
[00:02:00.723] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:00.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:42:0) after 1m0s
[00:03:02.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:42:0)
[00:03:02.150] Timer tick, asking Buildbucket for the build status
[00:03:02.559] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:02.560] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:43:0) after 1m0s
[00:04:02.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:43:0)
[00:04:02.573] Timer tick, asking Buildbucket for the build status
[00:04:02.644] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:02.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:44:0) after 1m0s
[00:05:03.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:44:0)
[00:05:03.190] Timer tick, asking Buildbucket for the build status
[00:05:03.319] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:03.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:45:0) after 1m0s
[00:06:03.389] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:45:0)
[00:06:03.389] Timer tick, asking Buildbucket for the build status
[00:06:03.671] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:03.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:46:0) after 1m0s
[00:07:03.765] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:46:0)
[00:07:03.765] Timer tick, asking Buildbucket for the build status
[00:07:03.850] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:03.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:47:0) after 1m0s
[00:08:03.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:47:0)
[00:08:03.890] Timer tick, asking Buildbucket for the build status
[00:08:04.196] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:04.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:48:0) after 1m0s
[00:09:04.365] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:48:0)
[00:09:04.365] Timer tick, asking Buildbucket for the build status
[00:09:04.666] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:04.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:49:0) after 1m0s
[00:10:04.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:49:0)
[00:10:04.746] Timer tick, asking Buildbucket for the build status
[00:10:05.038] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:05.038] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:50:0) after 1m0s
[00:11:05.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:50:0)
[00:11:05.083] Timer tick, asking Buildbucket for the build status
[00:11:05.161] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:05.161] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:51:0) after 1m0s
[00:12:05.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:51:0)
[00:12:05.193] Timer tick, asking Buildbucket for the build status
[00:12:05.274] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:05.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:52:0) after 1m0s
[00:13:05.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:52:0)
[00:13:05.349] Timer tick, asking Buildbucket for the build status
[00:13:05.708] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:05.708] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:53:0) after 1m0s
[00:14:05.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:53:0)
[00:14:05.732] Timer tick, asking Buildbucket for the build status
[00:14:05.964] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:05.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:54:0) after 1m0s
[00:15:06.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:54:0)
[00:15:06.006] Timer tick, asking Buildbucket for the build status
[00:15:06.084] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:06.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:55:0) after 1m0s
[00:16:06.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:55:0)
[00:16:06.108] Timer tick, asking Buildbucket for the build status
[00:16:06.216] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:06.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:56:0) after 1m0s
[00:17:06.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:56:0)
[00:17:06.397] Timer tick, asking Buildbucket for the build status
[00:17:06.702] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:06.702] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:57:0) after 1m0s
[00:18:06.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:57:0)
[00:18:06.868] Timer tick, asking Buildbucket for the build status
[00:18:07.153] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:07.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:58:0) after 1m0s
[00:19:07.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:58:0)
[00:19:07.246] Timer tick, asking Buildbucket for the build status
[00:19:07.297] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:07.297] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:59:0) after 1m0s
[00:20:07.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:59:0)
[00:20:07.325] Timer tick, asking Buildbucket for the build status
[00:20:07.405] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:07.405] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:60:0) after 1m0s
[00:21:07.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:60:0)
[00:21:07.544] Timer tick, asking Buildbucket for the build status
[00:21:07.617] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:07.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:61:0) after 1m0s
[00:22:07.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:61:0)
[00:22:07.718] Timer tick, asking Buildbucket for the build status
[00:22:07.781] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:07.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:62:0) after 1m0s
[00:23:07.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:62:0)
[00:23:07.915] Timer tick, asking Buildbucket for the build status
[00:23:08.039] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:08.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:63:0) after 1m0s
[00:24:08.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:63:0)
[00:24:08.151] Timer tick, asking Buildbucket for the build status
[00:24:08.218] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:08.218] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:64:0) after 1m0s
[00:25:08.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:64:0)
[00:25:08.295] Timer tick, asking Buildbucket for the build status
[00:25:08.358] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:08.358] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:65:0) after 1m0s
[00:26:08.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:65:0)
[00:26:08.383] Timer tick, asking Buildbucket for the build status
[00:26:08.542] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:08.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:66:0) after 1m0s
[00:27:08.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:66:0)
[00:27:08.618] Timer tick, asking Buildbucket for the build status
[00:27:08.906] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:08.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:67:0) after 1m0s
[00:28:08.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:67:0)
[00:28:08.939] Timer tick, asking Buildbucket for the build status
[00:28:09.064] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:09.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:68:0) after 1m0s
[00:29:09.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:68:0)
[00:29:09.123] Timer tick, asking Buildbucket for the build status
[00:29:09.391] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:09.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:69:0) after 1m0s
[00:30:09.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:69:0)
[00:30:09.517] Timer tick, asking Buildbucket for the build status
[00:30:09.611] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:09.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:70:0) after 1m0s
[00:31:09.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:70:0)
[00:31:09.656] Timer tick, asking Buildbucket for the build status
[00:31:09.727] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:09.728] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:71:0) after 1m0s
[00:32:09.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:71:0)
[00:32:09.769] Timer tick, asking Buildbucket for the build status
[00:32:09.912] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:09.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:72:0) after 1m0s
[00:33:09.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:72:0)
[00:33:09.997] Timer tick, asking Buildbucket for the build status
[00:33:10.166] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:10.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:73:0) after 1m0s
[00:34:10.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:73:0)
[00:34:10.236] Timer tick, asking Buildbucket for the build status
[00:34:10.324] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:10.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:74:0) after 1m0s
[00:35:10.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:74:0)
[00:35:10.403] Timer tick, asking Buildbucket for the build status
[00:35:10.675] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:10.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:75:0) after 1m0s
[00:36:10.706] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:75:0)
[00:36:10.706] Timer tick, asking Buildbucket for the build status
[00:36:10.766] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:10.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:76:0) after 1m0s
[00:37:10.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:76:0)
[00:37:10.829] Timer tick, asking Buildbucket for the build status
[00:37:10.886] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:10.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:77:0) after 1m0s
[00:38:11.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:77:0)
[00:38:11.037] Timer tick, asking Buildbucket for the build status
[00:38:12.245] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:12.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:78:0) after 1m0s
[00:39:12.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:78:0)
[00:39:12.330] Timer tick, asking Buildbucket for the build status
[00:39:12.393] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:12.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:79:0) after 1m0s
[00:40:12.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:79:0)
[00:40:12.540] Timer tick, asking Buildbucket for the build status
[00:40:12.807] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:12.807] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:80:0) after 1m0s
[00:41:12.918] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:80:0)
[00:41:12.918] Timer tick, asking Buildbucket for the build status
[00:41:12.984] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:12.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:81:0) after 1m0s
[00:42:13.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:81:0)
[00:42:13.025] Timer tick, asking Buildbucket for the build status
[00:42:13.086] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:13.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:82:0) after 1m0s
[00:43:13.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:82:0)
[00:43:13.262] Timer tick, asking Buildbucket for the build status
[00:43:13.375] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:13.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:83:0) after 1m0s
[00:44:13.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:83:0)
[00:44:13.461] Timer tick, asking Buildbucket for the build status
[00:44:13.533] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:13.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:84:0) after 1m0s
[00:45:13.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:84:0)
[00:45:13.593] Timer tick, asking Buildbucket for the build status
[00:45:13.653] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:13.653] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:85:0) after 1m0s
[00:46:13.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:85:0)
[00:46:13.752] Timer tick, asking Buildbucket for the build status
[00:46:13.904] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:13.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:86:0) after 1m0s
[00:47:13.941] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:86:0)
[00:47:13.941] Timer tick, asking Buildbucket for the build status
[00:47:14.014] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:14.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:87:0) after 1m0s
[00:48:14.115] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:87:0)
[00:48:14.115] Timer tick, asking Buildbucket for the build status
[00:48:14.229] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:14.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:88:0) after 1m0s
[00:49:14.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:88:0)
[00:49:14.302] Timer tick, asking Buildbucket for the build status
[00:49:14.375] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:14.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:89:0) after 1m0s
[00:50:14.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:89:0)
[00:50:14.377] Timer tick, asking Buildbucket for the build status
[00:50:14.474] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:14.474] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:90:0) after 1m0s
[00:51:14.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:90:0)
[00:51:14.484] Timer tick, asking Buildbucket for the build status
[00:51:14.550] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:14.550] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:91:0) after 1m0s
[00:52:14.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:91:0)
[00:52:14.576] Timer tick, asking Buildbucket for the build status
[00:52:14.641] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:14.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:92:0) after 1m0s
[00:53:14.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:92:0)
[00:53:14.632] Timer tick, asking Buildbucket for the build status
[00:53:14.731] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:14.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:93:0) after 1m0s
[00:54:14.760] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:93:0)
[00:54:14.760] Timer tick, asking Buildbucket for the build status
[00:54:14.885] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:14.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:94:0) after 1m0s
[00:55:14.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:94:0)
[00:55:14.975] Timer tick, asking Buildbucket for the build status
[00:55:15.185] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:15.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:95:0) after 1m0s
[00:56:15.244] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:95:0)
[00:56:15.244] Timer tick, asking Buildbucket for the build status
[00:56:15.326] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:15.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:96:0) after 1m0s
[00:57:15.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:96:0)
[00:57:15.396] Timer tick, asking Buildbucket for the build status
[00:57:15.542] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:15.542] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:97:0) after 1m0s
[00:58:15.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:97:0)
[00:58:15.602] Timer tick, asking Buildbucket for the build status
[00:58:15.740] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:15.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:98:0) after 1m0s
[00:59:15.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:98:0)
[00:59:15.725] Timer tick, asking Buildbucket for the build status
[00:59:15.787] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:15.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:99:0) after 1m0s
[01:00:15.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:99:0)
[01:00:15.874] Timer tick, asking Buildbucket for the build status
[01:00:16.102] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:16.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:100:0) after 1m0s
[01:01:16.177] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:100:0)
[01:01:16.177] Timer tick, asking Buildbucket for the build status
[01:01:16.242] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:16.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:101:0) after 1m0s
[01:02:16.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:101:0)
[01:02:16.230] Timer tick, asking Buildbucket for the build status
[01:02:16.299] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:16.299] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:102:0) after 1m0s
[01:03:16.327] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:102:0)
[01:03:16.327] Timer tick, asking Buildbucket for the build status
[01:03:16.432] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:16.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:103:0) after 1m0s
[01:04:16.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:103:0)
[01:04:16.436] Timer tick, asking Buildbucket for the build status
[01:04:16.494] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:16.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:104:0) after 1m0s
[01:05:16.571] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:104:0)
[01:05:16.571] Timer tick, asking Buildbucket for the build status
[01:05:16.766] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:16.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:105:0) after 1m0s
[01:06:16.795] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:105:0)
[01:06:16.795] Timer tick, asking Buildbucket for the build status
[01:06:16.924] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:16.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:106:0) after 1m0s
[01:07:17.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:106:0)
[01:07:17.001] Timer tick, asking Buildbucket for the build status
[01:07:17.068] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:17.068] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:107:0) after 1m0s
[01:08:17.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:107:0)
[01:08:17.148] Timer tick, asking Buildbucket for the build status
[01:08:17.261] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:17.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:108:0) after 1m0s
[01:09:17.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:108:0)
[01:09:17.293] Timer tick, asking Buildbucket for the build status
[01:09:17.365] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:17.365] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:109:0) after 1m0s
[01:10:17.526] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:109:0)
[01:10:17.526] Timer tick, asking Buildbucket for the build status
[01:10:17.587] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:17.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:110:0) after 1m0s
[01:11:17.686] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:110:0)
[01:11:17.686] Timer tick, asking Buildbucket for the build status
[01:11:17.768] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:17.768] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:111:0) after 1m0s
[01:12:17.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:111:0)
[01:12:17.898] Timer tick, asking Buildbucket for the build status
[01:12:17.955] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:17.955] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:112:0) after 1m0s
[01:13:18.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:112:0)
[01:13:18.108] Timer tick, asking Buildbucket for the build status
[01:13:18.200] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:18.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:113:0) after 1m0s
[01:14:18.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:113:0)
[01:14:18.271] Timer tick, asking Buildbucket for the build status
[01:14:18.666] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:18.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:114:0) after 1m0s
[01:15:18.723] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:114:0)
[01:15:18.723] Timer tick, asking Buildbucket for the build status
[01:15:18.795] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:18.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:115:0) after 1m0s
[01:16:18.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:115:0)
[01:16:18.868] Timer tick, asking Buildbucket for the build status
[01:16:18.985] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:18.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:116:0) after 1m0s
[01:17:19.103] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:116:0)
[01:17:19.103] Timer tick, asking Buildbucket for the build status
[01:17:19.165] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:19.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:117:0) after 1m0s
[01:18:19.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:117:0)
[01:18:19.214] Timer tick, asking Buildbucket for the build status
[01:18:19.371] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:19.371] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:118:0) after 1m0s
[01:19:19.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:118:0)
[01:19:19.384] Timer tick, asking Buildbucket for the build status
[01:19:19.452] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:19.452] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:119:0) after 1m0s
[01:20:19.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:119:0)
[01:20:19.493] Timer tick, asking Buildbucket for the build status
[01:20:19.574] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:19.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:120:0) after 1m0s
[01:21:19.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:120:0)
[01:21:19.673] Timer tick, asking Buildbucket for the build status
[01:21:19.749] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:19.749] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:121:0) after 1m0s
[01:22:19.724] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:121:0)
[01:22:19.724] Timer tick, asking Buildbucket for the build status
[01:22:19.814] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:19.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:122:0) after 1m0s
[01:23:19.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:122:0)
[01:23:19.879] Timer tick, asking Buildbucket for the build status
[01:23:20.003] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:20.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:123:0) after 1m0s
[01:24:20.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:123:0)
[01:24:20.029] Timer tick, asking Buildbucket for the build status
[01:24:20.095] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:20.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:124:0) after 1m0s
[01:25:20.169] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:124:0)
[01:25:20.169] Timer tick, asking Buildbucket for the build status
[01:25:20.306] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:20.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:125:0) after 1m0s
[01:26:20.313] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:125:0)
[01:26:20.313] Timer tick, asking Buildbucket for the build status
[01:26:20.563] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:20.563] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:126:0) after 1m0s
[01:27:20.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:126:0)
[01:27:20.607] Timer tick, asking Buildbucket for the build status
[01:27:20.691] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:20.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:127:0) after 1m0s
[01:28:20.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:127:0)
[01:28:20.850] Timer tick, asking Buildbucket for the build status
[01:28:20.945] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:20.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:128:0) after 1m0s
[01:29:21.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:128:0)
[01:29:21.056] Timer tick, asking Buildbucket for the build status
[01:29:21.129] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:21.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:129:0) after 1m0s
[01:30:21.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:129:0)
[01:30:21.236] Timer tick, asking Buildbucket for the build status
[01:30:24.159] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:24.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:130:0) after 1m0s
[01:31:24.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:130:0)
[01:31:24.195] Timer tick, asking Buildbucket for the build status
[01:31:24.262] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:24.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:131:0) after 1m0s
[01:32:24.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:131:0)
[01:32:24.273] Timer tick, asking Buildbucket for the build status
[01:32:24.345] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:24.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:132:0) after 1m0s
[01:33:24.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:132:0)
[01:33:24.384] Timer tick, asking Buildbucket for the build status
[01:33:24.551] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:24.551] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:133:0) after 1m0s
[01:34:24.622] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:133:0)
[01:34:24.622] Timer tick, asking Buildbucket for the build status
[01:34:24.683] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:24.683] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:134:0) after 1m0s
[01:35:24.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:134:0)
[01:35:24.839] Timer tick, asking Buildbucket for the build status
[01:35:24.903] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:24.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:135:0) after 1m0s
[01:36:24.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:135:0)
[01:36:24.994] Timer tick, asking Buildbucket for the build status
[01:36:25.072] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:25.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:136:0) after 1m0s
[01:37:25.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:136:0)
[01:37:25.123] Timer tick, asking Buildbucket for the build status
[01:37:25.212] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:25.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:137:0) after 1m0s
[01:38:25.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:137:0)
[01:38:25.243] Timer tick, asking Buildbucket for the build status
[01:38:25.494] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:25.494] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:138:0) after 1m0s
[01:39:25.610] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:138:0)
[01:39:25.610] Timer tick, asking Buildbucket for the build status
[01:39:25.672] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:25.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:139:0) after 1m0s
[01:40:25.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:139:0)
[01:40:25.697] Timer tick, asking Buildbucket for the build status
[01:40:25.913] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:25.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:140:0) after 1m0s
[01:41:25.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:140:0)
[01:41:25.947] Timer tick, asking Buildbucket for the build status
[01:41:26.028] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:26.028] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:141:0) after 1m0s
[01:42:26.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:141:0)
[01:42:26.128] Timer tick, asking Buildbucket for the build status
[01:42:26.835] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:26.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:142:0) after 1m0s
[01:43:26.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:142:0)
[01:43:26.867] Timer tick, asking Buildbucket for the build status
[01:43:26.958] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:26.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:143:0) after 1m0s
[01:44:26.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:143:0)
[01:44:26.994] Timer tick, asking Buildbucket for the build status
[01:44:27.088] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:27.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:144:0) after 1m0s
[01:45:27.209] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:144:0)
[01:45:27.209] Timer tick, asking Buildbucket for the build status
[01:45:27.319] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:27.320] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:145:0) after 1m0s
[01:46:27.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:145:0)
[01:46:27.363] Timer tick, asking Buildbucket for the build status
[01:46:27.459] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:27.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:146:0) after 1m0s
[01:47:27.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:146:0)
[01:47:27.544] Timer tick, asking Buildbucket for the build status
[01:47:27.885] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:27.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:147:0) after 1m0s
[01:48:27.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:147:0)
[01:48:27.953] Timer tick, asking Buildbucket for the build status
[01:48:28.105] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:28.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:148:0) after 1m0s
[01:49:28.151] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:148:0)
[01:49:28.151] Timer tick, asking Buildbucket for the build status
[01:49:28.378] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:28.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:149:0) after 1m0s
[01:50:28.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:149:0)
[01:50:28.405] Timer tick, asking Buildbucket for the build status
[01:50:28.470] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:28.470] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:150:0) after 1m0s
[01:51:28.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:150:0)
[01:51:28.513] Timer tick, asking Buildbucket for the build status
[01:51:28.586] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:28.586] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:151:0) after 1m0s
[01:52:28.640] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:151:0)
[01:52:28.640] Timer tick, asking Buildbucket for the build status
[01:52:28.714] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:28.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:152:0) after 1m0s
[01:53:28.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:152:0)
[01:53:28.710] Timer tick, asking Buildbucket for the build status
[01:53:28.814] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:28.814] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:153:0) after 1m0s
[01:54:28.895] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:153:0)
[01:54:28.895] Timer tick, asking Buildbucket for the build status
[01:54:29.019] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:29.019] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:154:0) after 1m0s
[01:55:29.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:154:0)
[01:55:29.086] Timer tick, asking Buildbucket for the build status
[01:55:29.292] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:29.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:155:0) after 1m0s
[01:56:29.355] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:155:0)
[01:56:29.355] Timer tick, asking Buildbucket for the build status
[01:56:29.610] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:29.610] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:156:0) after 1m0s
[01:57:29.758] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:156:0)
[01:57:29.758] Timer tick, asking Buildbucket for the build status
[01:57:29.820] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:29.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:157:0) after 1m0s
[01:58:29.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:157:0)
[01:58:29.827] Timer tick, asking Buildbucket for the build status
[01:58:29.928] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:29.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:158:0) after 1m0s
[01:59:30.063] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:158:0)
[01:59:30.063] Timer tick, asking Buildbucket for the build status
[01:59:30.127] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:30.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:159:0) after 1m0s
[02:00:30.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:159:0)
[02:00:30.158] Timer tick, asking Buildbucket for the build status
[02:00:30.303] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:30.304] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:160:0) after 1m0s
[02:01:30.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:160:0)
[02:01:30.340] Timer tick, asking Buildbucket for the build status
[02:01:30.404] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:30.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:161:0) after 1m0s
[02:02:30.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:161:0)
[02:02:30.628] Timer tick, asking Buildbucket for the build status
[02:02:30.806] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:30.806] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:162:0) after 1m0s
[02:03:30.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:162:0)
[02:03:30.935] Timer tick, asking Buildbucket for the build status
[02:03:31.092] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:31.092] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:163:0) after 1m0s
[02:04:31.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:163:0)
[02:04:31.193] Timer tick, asking Buildbucket for the build status
[02:04:31.319] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:31.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:164:0) after 1m0s
[02:05:31.409] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:164:0)
[02:05:31.409] Timer tick, asking Buildbucket for the build status
[02:05:31.468] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:31.468] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:165:0) after 1m0s
[02:06:31.642] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:165:0)
[02:06:31.642] Timer tick, asking Buildbucket for the build status
[02:06:31.723] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:31.723] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:166:0) after 1m0s
[02:07:31.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:166:0)
[02:07:31.797] Timer tick, asking Buildbucket for the build status
[02:07:31.869] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:31.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:167:0) after 1m0s
[02:08:31.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:167:0)
[02:08:31.907] Timer tick, asking Buildbucket for the build status
[02:08:32.265] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:32.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:168:0) after 1m0s
[02:09:32.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:168:0)
[02:09:32.330] Timer tick, asking Buildbucket for the build status
[02:09:32.431] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:32.431] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:169:0) after 1m0s
[02:10:32.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:169:0)
[02:10:32.623] Timer tick, asking Buildbucket for the build status
[02:10:32.677] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:32.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:170:0) after 1m0s
[02:11:32.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:170:0)
[02:11:32.897] Timer tick, asking Buildbucket for the build status
[02:11:32.960] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:32.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:171:0) after 1m0s
[02:12:33.051] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:171:0)
[02:12:33.051] Timer tick, asking Buildbucket for the build status
[02:12:33.217] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:33.217] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:172:0) after 1m0s
[02:13:33.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:172:0)
[02:13:33.324] Timer tick, asking Buildbucket for the build status
[02:13:33.459] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:33.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:173:0) after 1m0s
[02:14:33.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:173:0)
[02:14:33.510] Timer tick, asking Buildbucket for the build status
[02:14:33.620] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:33.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:174:0) after 1m0s
[02:15:33.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:174:0)
[02:15:33.748] Timer tick, asking Buildbucket for the build status
[02:15:33.860] Build 8865969342920887008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:33.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031399404878190912:175:0) after 1m0s
[02:16:05.609] Received PubSub notification, asking Buildbucket for the build status
[02:16:05.882] Build 8865969342920887008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:16:05.883] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1603160164797770",
"created_by": "project:infra",
"created_ts": "1603149769819677",
"id": "8865969342920887008",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4296.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"37d8e3e3-11dc-4512-8306-a814fef91be9\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4296.4\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-6ruy\"], \"image\": [\"chrome-xenial-20101600-2d400e1627f\"], \"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\": [\"5601-97d7e7d\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603149792800059",
"status": "COMPLETED",
"status_changed_ts": "1603160165334750",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031399404878190912",
"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/8865969342920887008/+/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:4f5bfdb606ec1510",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1603160165351311",
"url": "https://ci.chromium.org/b/8865969342920887008",
"utcnow_ts": "1603160165875588"
}
}
[02:16:05.883] Invocation finished in 2h53m17.314783394s with status SUCCEEDED