[17:22:00.324] New invocation is queued and will start shortly
[17:22:00.324] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[17:22:01.730] Starting the invocation (attempt 1)
[17:22:01.783] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:22:01.783] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:22:01.783] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9049541498004739312",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"83.0.4102.3\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"dbf61594-f4ed-499d-88d6-b226b9ca4bed\",\"title\":\"publish_tarball/0\"}]},\"version\":\"83.0.4102.3\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9049541498004739312",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[17:22:03.359] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1585848121927333",
"id": "8884111435660996224",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4102.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"dbf61594-f4ed-499d-88d6-b226b9ca4bed\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4102.3\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585848122780794",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9049541498004739312",
"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/8884111435660996224/+/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": "1585848122780961",
"url": "https://ci.chromium.org/b/8884111435660996224",
"utcnow_ts": "1585848123330102"
}
}
[17:22:03.359] Task URL: https://ci.chromium.org/b/8884111435660996224
[17:22:03.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:2:0) after 1m0s
[17:22:33.970] Received PubSub notification, asking Buildbucket for the build status
[17:22:34.041] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:03.413] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:2:0)
[17:23:03.413] Timer tick, asking Buildbucket for the build status
[17:23:03.579] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:03.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:4:0) after 1m0s
[17:24:03.681] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:4:0)
[17:24:03.681] Timer tick, asking Buildbucket for the build status
[17:24:03.920] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:03.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:5:0) after 1m0s
[17:25:04.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:5:0)
[17:25:04.098] Timer tick, asking Buildbucket for the build status
[17:25:04.901] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:04.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:6:0) after 1m0s
[17:26:04.995] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:6:0)
[17:26:04.995] Timer tick, asking Buildbucket for the build status
[17:26:05.193] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:05.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:7:0) after 1m0s
[17:27:05.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:7:0)
[17:27:05.261] Timer tick, asking Buildbucket for the build status
[17:27:06.676] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:06.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:8:0) after 1m0s
[17:28:06.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:8:0)
[17:28:06.818] Timer tick, asking Buildbucket for the build status
[17:28:07.054] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:07.054] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:9:0) after 1m0s
[17:29:07.087] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:9:0)
[17:29:07.087] Timer tick, asking Buildbucket for the build status
[17:29:07.223] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:07.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:10:0) after 1m0s
[17:30:07.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:10:0)
[17:30:07.262] Timer tick, asking Buildbucket for the build status
[17:30:07.407] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:07.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:11:0) after 1m0s
[17:31:07.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:11:0)
[17:31:07.499] Timer tick, asking Buildbucket for the build status
[17:31:07.665] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:07.665] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:12:0) after 1m0s
[17:32:07.829] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:12:0)
[17:32:07.829] Timer tick, asking Buildbucket for the build status
[17:32:08.142] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:08.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:13:0) after 1m0s
[17:33:08.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:13:0)
[17:33:08.265] Timer tick, asking Buildbucket for the build status
[17:33:08.516] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:08.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:14:0) after 1m0s
[17:34:08.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:14:0)
[17:34:08.566] Timer tick, asking Buildbucket for the build status
[17:34:08.678] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:08.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:15:0) after 1m0s
[17:35:08.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:15:0)
[17:35:08.768] Timer tick, asking Buildbucket for the build status
[17:35:09.148] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:09.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:16:0) after 1m0s
[17:36:09.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:16:0)
[17:36:09.257] Timer tick, asking Buildbucket for the build status
[17:36:09.442] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:09.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:17:0) after 1m0s
[17:37:09.421] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:17:0)
[17:37:09.421] Timer tick, asking Buildbucket for the build status
[17:37:10.292] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:10.292] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:18:0) after 1m0s
[17:38:10.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:18:0)
[17:38:10.531] Timer tick, asking Buildbucket for the build status
[17:38:12.699] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:12.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:19:0) after 1m0s
[17:39:12.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:19:0)
[17:39:12.739] Timer tick, asking Buildbucket for the build status
[17:39:12.916] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:12.916] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:20:0) after 1m0s
[17:40:13.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:20:0)
[17:40:13.019] Timer tick, asking Buildbucket for the build status
[17:40:13.293] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:13.293] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:21:0) after 1m0s
[17:41:13.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:21:0)
[17:41:13.356] Timer tick, asking Buildbucket for the build status
[17:41:14.154] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:14.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:22:0) after 1m0s
[17:42:14.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:22:0)
[17:42:14.241] Timer tick, asking Buildbucket for the build status
[17:42:14.544] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:14.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:23:0) after 1m0s
[17:43:14.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:23:0)
[17:43:14.628] Timer tick, asking Buildbucket for the build status
[17:43:15.460] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:15.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:24:0) after 1m0s
[17:44:15.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:24:0)
[17:44:15.511] Timer tick, asking Buildbucket for the build status
[17:44:15.694] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:15.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:25:0) after 1m0s
[17:45:15.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:25:0)
[17:45:15.721] Timer tick, asking Buildbucket for the build status
[17:45:16.037] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:16.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:26:0) after 1m0s
[17:46:16.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:26:0)
[17:46:16.073] Timer tick, asking Buildbucket for the build status
[17:46:16.237] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:16.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:27:0) after 1m0s
[17:47:16.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:27:0)
[17:47:16.256] Timer tick, asking Buildbucket for the build status
[17:47:16.528] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:16.528] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:28:0) after 1m0s
[17:48:16.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:28:0)
[17:48:16.557] Timer tick, asking Buildbucket for the build status
[17:48:16.776] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:16.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:29:0) after 1m0s
[17:49:17.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:29:0)
[17:49:17.079] Timer tick, asking Buildbucket for the build status
[17:49:17.521] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:17.521] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:30:0) after 1m0s
[17:50:17.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:30:0)
[17:50:17.527] Timer tick, asking Buildbucket for the build status
[17:50:17.744] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:17.744] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:31:0) after 1m0s
[17:51:17.807] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:31:0)
[17:51:17.807] Timer tick, asking Buildbucket for the build status
[17:51:18.134] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:18.134] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:32:0) after 1m0s
[17:52:18.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:32:0)
[17:52:18.191] Timer tick, asking Buildbucket for the build status
[17:52:18.463] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:18.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:33:0) after 1m0s
[17:53:18.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:33:0)
[17:53:18.678] Timer tick, asking Buildbucket for the build status
[17:53:19.216] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:19.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:34:0) after 1m0s
[17:54:19.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:34:0)
[17:54:19.275] Timer tick, asking Buildbucket for the build status
[17:54:19.362] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:19.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:35:0) after 1m0s
[17:55:19.528] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:35:0)
[17:55:19.528] Timer tick, asking Buildbucket for the build status
[17:55:20.345] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:20.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:36:0) after 1m0s
[17:56:20.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:36:0)
[17:56:20.496] Timer tick, asking Buildbucket for the build status
[17:56:20.901] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:20.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:37:0) after 1m0s
[17:57:20.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:37:0)
[17:57:20.979] Timer tick, asking Buildbucket for the build status
[17:57:22.012] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:22.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:38:0) after 1m0s
[17:58:22.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:38:0)
[17:58:22.046] Timer tick, asking Buildbucket for the build status
[17:58:22.208] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:22.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:39:0) after 1m0s
[17:59:22.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:39:0)
[17:59:22.279] Timer tick, asking Buildbucket for the build status
[17:59:23.036] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:23.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:40:0) after 1m0s
[18:00:23.052] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:40:0)
[18:00:23.052] Timer tick, asking Buildbucket for the build status
[18:00:23.441] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:23.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:41:0) after 1m0s
[18:01:23.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:41:0)
[18:01:23.415] Timer tick, asking Buildbucket for the build status
[18:01:23.623] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:23.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:42:0) after 1m0s
[18:02:23.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:42:0)
[18:02:23.645] Timer tick, asking Buildbucket for the build status
[18:02:23.778] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:23.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:43:0) after 1m0s
[18:03:23.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:43:0)
[18:03:23.856] Timer tick, asking Buildbucket for the build status
[18:03:24.070] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:24.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:44:0) after 1m0s
[18:04:24.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:44:0)
[18:04:24.186] Timer tick, asking Buildbucket for the build status
[18:04:24.615] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:24.615] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:45:0) after 1m0s
[18:05:24.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:45:0)
[18:05:24.638] Timer tick, asking Buildbucket for the build status
[18:05:25.132] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:25.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:46:0) after 1m0s
[18:06:25.210] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:46:0)
[18:06:25.210] Timer tick, asking Buildbucket for the build status
[18:06:25.664] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:25.664] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:47:0) after 1m0s
[18:07:25.798] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:47:0)
[18:07:25.798] Timer tick, asking Buildbucket for the build status
[18:07:27.291] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:27.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:48:0) after 1m0s
[18:08:27.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:48:0)
[18:08:27.296] Timer tick, asking Buildbucket for the build status
[18:08:27.657] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:27.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:49:0) after 1m0s
[18:09:27.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:49:0)
[18:09:27.705] Timer tick, asking Buildbucket for the build status
[18:09:28.170] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:28.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:50:0) after 1m0s
[18:10:28.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:50:0)
[18:10:28.274] Timer tick, asking Buildbucket for the build status
[18:10:28.641] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:28.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:51:0) after 1m0s
[18:11:29.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:51:0)
[18:11:29.363] Timer tick, asking Buildbucket for the build status
[18:11:29.555] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:29.555] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:52:0) after 1m0s
[18:12:29.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:52:0)
[18:12:29.801] Timer tick, asking Buildbucket for the build status
[18:12:30.174] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:30.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:53:0) after 1m0s
[18:13:30.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:53:0)
[18:13:30.605] Timer tick, asking Buildbucket for the build status
[18:13:30.773] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:30.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:54:0) after 1m0s
[18:14:30.971] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:54:0)
[18:14:30.971] Timer tick, asking Buildbucket for the build status
[18:14:31.659] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:31.659] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:55:0) after 1m0s
[18:15:31.698] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:55:0)
[18:15:31.698] Timer tick, asking Buildbucket for the build status
[18:15:31.852] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:31.852] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:56:0) after 1m0s
[18:16:31.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:56:0)
[18:16:31.915] Timer tick, asking Buildbucket for the build status
[18:16:32.127] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:32.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:57:0) after 1m0s
[18:17:32.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:57:0)
[18:17:32.271] Timer tick, asking Buildbucket for the build status
[18:17:32.430] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:32.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:58:0) after 1m0s
[18:18:32.482] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:58:0)
[18:18:32.482] Timer tick, asking Buildbucket for the build status
[18:18:32.791] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:32.791] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:59:0) after 1m0s
[18:19:32.839] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:59:0)
[18:19:32.839] Timer tick, asking Buildbucket for the build status
[18:19:34.088] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:34.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:60:0) after 1m0s
[18:20:34.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:60:0)
[18:20:34.100] Timer tick, asking Buildbucket for the build status
[18:20:34.205] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:34.205] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:61:0) after 1m0s
[18:21:34.332] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:61:0)
[18:21:34.332] Timer tick, asking Buildbucket for the build status
[18:21:34.485] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:34.485] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:62:0) after 1m0s
[18:22:34.513] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:62:0)
[18:22:34.513] Timer tick, asking Buildbucket for the build status
[18:22:34.662] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:34.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:63:0) after 1m0s
[18:23:34.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:63:0)
[18:23:34.776] Timer tick, asking Buildbucket for the build status
[18:23:34.923] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:34.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:64:0) after 1m0s
[18:24:35.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:64:0)
[18:24:35.003] Timer tick, asking Buildbucket for the build status
[18:24:36.316] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:36.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:65:0) after 1m0s
[18:25:36.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:65:0)
[18:25:36.670] Timer tick, asking Buildbucket for the build status
[18:25:37.379] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:37.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:66:0) after 1m0s
[18:26:37.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:66:0)
[18:26:37.483] Timer tick, asking Buildbucket for the build status
[18:26:37.685] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:37.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:67:0) after 1m0s
[18:27:38.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:67:0)
[18:27:38.026] Timer tick, asking Buildbucket for the build status
[18:27:39.018] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:39.018] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:68:0) after 1m0s
[18:28:39.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:68:0)
[18:28:39.093] Timer tick, asking Buildbucket for the build status
[18:28:39.276] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:39.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:69:0) after 1m0s
[18:29:39.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:69:0)
[18:29:39.333] Timer tick, asking Buildbucket for the build status
[18:29:39.547] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:39.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:70:0) after 1m0s
[18:30:39.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:70:0)
[18:30:39.794] Timer tick, asking Buildbucket for the build status
[18:30:40.048] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:40.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:71:0) after 1m0s
[18:31:40.223] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:71:0)
[18:31:40.223] Timer tick, asking Buildbucket for the build status
[18:31:40.444] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:40.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:72:0) after 1m0s
[18:32:40.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:72:0)
[18:32:40.558] Timer tick, asking Buildbucket for the build status
[18:32:41.046] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:41.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:73:0) after 1m0s
[18:33:41.139] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:73:0)
[18:33:41.139] Timer tick, asking Buildbucket for the build status
[18:33:41.322] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:41.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:74:0) after 1m0s
[18:34:41.461] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:74:0)
[18:34:41.461] Timer tick, asking Buildbucket for the build status
[18:34:42.722] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:42.722] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:75:0) after 1m0s
[18:35:43.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:75:0)
[18:35:43.065] Timer tick, asking Buildbucket for the build status
[18:35:43.493] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:43.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:76:0) after 1m0s
[18:36:43.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:76:0)
[18:36:43.846] Timer tick, asking Buildbucket for the build status
[18:36:44.014] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:44.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:77:0) after 1m0s
[18:37:44.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:77:0)
[18:37:44.083] Timer tick, asking Buildbucket for the build status
[18:37:44.229] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:44.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:78:0) after 1m0s
[18:38:44.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:78:0)
[18:38:44.468] Timer tick, asking Buildbucket for the build status
[18:38:44.679] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:44.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:79:0) after 1m0s
[18:39:44.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:79:0)
[18:39:44.809] Timer tick, asking Buildbucket for the build status
[18:39:45.273] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:45.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:80:0) after 1m0s
[18:40:45.923] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:80:0)
[18:40:45.923] Timer tick, asking Buildbucket for the build status
[18:40:46.258] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:46.258] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:81:0) after 1m0s
[18:41:46.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:81:0)
[18:41:46.252] Timer tick, asking Buildbucket for the build status
[18:41:46.390] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:46.390] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:82:0) after 1m0s
[18:42:46.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:82:0)
[18:42:46.484] Timer tick, asking Buildbucket for the build status
[18:42:46.746] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:46.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:83:0) after 1m0s
[18:43:46.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:83:0)
[18:43:46.962] Timer tick, asking Buildbucket for the build status
[18:43:47.103] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:47.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:84:0) after 1m0s
[18:44:47.158] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:84:0)
[18:44:47.158] Timer tick, asking Buildbucket for the build status
[18:44:47.395] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:47.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:85:0) after 1m0s
[18:45:47.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:85:0)
[18:45:47.826] Timer tick, asking Buildbucket for the build status
[18:45:48.238] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:48.238] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:86:0) after 1m0s
[18:46:48.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:86:0)
[18:46:48.416] Timer tick, asking Buildbucket for the build status
[18:46:48.577] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:48.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:87:0) after 1m0s
[18:47:48.887] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:87:0)
[18:47:48.887] Timer tick, asking Buildbucket for the build status
[18:47:49.164] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:49.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:88:0) after 1m0s
[18:48:49.333] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:88:0)
[18:48:49.333] Timer tick, asking Buildbucket for the build status
[18:48:49.543] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:49.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:89:0) after 1m0s
[18:49:49.828] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:89:0)
[18:49:49.828] Timer tick, asking Buildbucket for the build status
[18:49:50.311] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:50.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:90:0) after 1m0s
[18:50:50.527] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:90:0)
[18:50:50.527] Timer tick, asking Buildbucket for the build status
[18:50:51.062] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:51.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:91:0) after 1m0s
[18:51:51.225] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:91:0)
[18:51:51.225] Timer tick, asking Buildbucket for the build status
[18:51:51.356] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:51.356] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:92:0) after 1m0s
[18:52:51.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:92:0)
[18:52:51.629] Timer tick, asking Buildbucket for the build status
[18:52:51.841] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:51.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:93:0) after 1m0s
[18:53:52.154] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:93:0)
[18:53:52.154] Timer tick, asking Buildbucket for the build status
[18:53:52.334] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:52.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:94:0) after 1m0s
[18:54:52.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:94:0)
[18:54:52.383] Timer tick, asking Buildbucket for the build status
[18:54:52.733] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:52.733] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:95:0) after 1m0s
[18:55:52.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:95:0)
[18:55:52.864] Timer tick, asking Buildbucket for the build status
[18:55:53.106] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:53.106] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:96:0) after 1m0s
[18:56:53.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:96:0)
[18:56:53.229] Timer tick, asking Buildbucket for the build status
[18:56:53.407] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:53.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:97:0) after 1m0s
[18:57:53.708] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:97:0)
[18:57:53.708] Timer tick, asking Buildbucket for the build status
[18:57:53.922] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:53.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:98:0) after 1m0s
[18:58:54.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:98:0)
[18:58:54.066] Timer tick, asking Buildbucket for the build status
[18:58:54.209] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:54.209] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:99:0) after 1m0s
[18:59:54.371] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:99:0)
[18:59:54.371] Timer tick, asking Buildbucket for the build status
[18:59:54.632] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:54.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:100:0) after 1m0s
[19:00:54.963] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:100:0)
[19:00:54.963] Timer tick, asking Buildbucket for the build status
[19:00:55.429] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:55.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:101:0) after 1m0s
[19:01:55.665] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:101:0)
[19:01:55.665] Timer tick, asking Buildbucket for the build status
[19:01:55.850] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:55.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:102:0) after 1m0s
[19:02:56.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:102:0)
[19:02:56.008] Timer tick, asking Buildbucket for the build status
[19:02:56.231] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:56.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:103:0) after 1m0s
[19:03:56.410] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:103:0)
[19:03:56.410] Timer tick, asking Buildbucket for the build status
[19:03:56.597] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:56.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:104:0) after 1m0s
[19:04:56.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:104:0)
[19:04:56.738] Timer tick, asking Buildbucket for the build status
[19:04:57.102] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:57.102] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:105:0) after 1m0s
[19:05:57.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:105:0)
[19:05:57.206] Timer tick, asking Buildbucket for the build status
[19:05:57.425] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:57.425] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:106:0) after 1m0s
[19:06:57.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:106:0)
[19:06:57.517] Timer tick, asking Buildbucket for the build status
[19:06:57.748] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:57.748] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:107:0) after 1m0s
[19:07:57.770] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:107:0)
[19:07:57.770] Timer tick, asking Buildbucket for the build status
[19:07:58.021] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:58.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:108:0) after 1m0s
[19:08:58.068] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:108:0)
[19:08:58.068] Timer tick, asking Buildbucket for the build status
[19:08:58.458] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:58.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:109:0) after 1m0s
[19:09:58.484] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:109:0)
[19:09:58.484] Timer tick, asking Buildbucket for the build status
[19:09:59.097] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:59.097] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:110:0) after 1m0s
[19:10:59.288] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:110:0)
[19:10:59.288] Timer tick, asking Buildbucket for the build status
[19:10:59.514] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:59.514] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:111:0) after 1m0s
[19:11:59.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:111:0)
[19:11:59.577] Timer tick, asking Buildbucket for the build status
[19:11:59.827] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:59.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:112:0) after 1m0s
[19:12:59.909] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:112:0)
[19:12:59.909] Timer tick, asking Buildbucket for the build status
[19:13:00.086] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:00.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:113:0) after 1m0s
[19:14:00.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:113:0)
[19:14:00.143] Timer tick, asking Buildbucket for the build status
[19:14:00.354] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:00.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:114:0) after 1m0s
[19:15:00.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:114:0)
[19:15:00.329] Timer tick, asking Buildbucket for the build status
[19:15:00.526] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:00.526] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:115:0) after 1m0s
[19:16:00.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:115:0)
[19:16:00.591] Timer tick, asking Buildbucket for the build status
[19:16:00.743] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:00.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:116:0) after 1m0s
[19:17:01.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:116:0)
[19:17:01.024] Timer tick, asking Buildbucket for the build status
[19:17:01.143] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:01.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:117:0) after 1m0s
[19:18:01.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:117:0)
[19:18:01.418] Timer tick, asking Buildbucket for the build status
[19:18:01.927] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:01.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:118:0) after 1m0s
[19:19:02.077] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:118:0)
[19:19:02.077] Timer tick, asking Buildbucket for the build status
[19:19:02.236] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:02.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:119:0) after 1m0s
[19:20:02.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:119:0)
[19:20:02.479] Timer tick, asking Buildbucket for the build status
[19:20:02.627] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:02.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:120:0) after 1m0s
[19:21:02.762] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:120:0)
[19:21:02.762] Timer tick, asking Buildbucket for the build status
[19:21:02.967] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:02.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:121:0) after 1m0s
[19:22:03.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:121:0)
[19:22:03.297] Timer tick, asking Buildbucket for the build status
[19:22:03.537] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:03.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:122:0) after 1m0s
[19:23:03.576] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:122:0)
[19:23:03.576] Timer tick, asking Buildbucket for the build status
[19:23:03.763] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:03.763] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:123:0) after 1m0s
[19:24:03.791] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:123:0)
[19:24:03.791] Timer tick, asking Buildbucket for the build status
[19:24:04.448] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:04.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:124:0) after 1m0s
[19:25:04.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:124:0)
[19:25:04.538] Timer tick, asking Buildbucket for the build status
[19:25:04.954] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:04.954] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:125:0) after 1m0s
[19:26:05.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:125:0)
[19:26:05.107] Timer tick, asking Buildbucket for the build status
[19:26:05.552] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:05.552] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:126:0) after 1m0s
[19:27:05.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:126:0)
[19:27:05.581] Timer tick, asking Buildbucket for the build status
[19:27:05.740] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:05.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:127:0) after 1m0s
[19:28:05.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:127:0)
[19:28:05.862] Timer tick, asking Buildbucket for the build status
[19:28:06.262] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:06.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:128:0) after 1m0s
[19:29:06.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:128:0)
[19:29:06.336] Timer tick, asking Buildbucket for the build status
[19:29:07.777] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:07.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:129:0) after 1m0s
[19:30:07.893] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:129:0)
[19:30:07.893] Timer tick, asking Buildbucket for the build status
[19:30:08.134] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:08.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:130:0) after 1m0s
[19:31:08.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:130:0)
[19:31:08.298] Timer tick, asking Buildbucket for the build status
[19:31:08.442] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:08.442] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:131:0) after 1m0s
[19:32:08.663] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:131:0)
[19:32:08.663] Timer tick, asking Buildbucket for the build status
[19:32:08.848] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:08.848] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:132:0) after 1m0s
[19:33:08.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:132:0)
[19:33:08.938] Timer tick, asking Buildbucket for the build status
[19:33:09.112] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:09.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:133:0) after 1m0s
[19:34:09.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:133:0)
[19:34:09.331] Timer tick, asking Buildbucket for the build status
[19:34:09.835] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:09.835] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:134:0) after 1m0s
[19:35:09.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:134:0)
[19:35:09.902] Timer tick, asking Buildbucket for the build status
[19:35:11.921] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:11.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:135:0) after 1m0s
[19:36:11.962] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:135:0)
[19:36:11.962] Timer tick, asking Buildbucket for the build status
[19:36:13.922] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:13.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:136:0) after 1m0s
[19:37:14.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:136:0)
[19:37:14.035] Timer tick, asking Buildbucket for the build status
[19:37:14.439] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:14.439] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:137:0) after 1m0s
[19:38:14.518] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:137:0)
[19:38:14.518] Timer tick, asking Buildbucket for the build status
[19:38:14.693] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:14.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:138:0) after 1m0s
[19:39:14.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:138:0)
[19:39:14.715] Timer tick, asking Buildbucket for the build status
[19:39:14.861] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:14.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:139:0) after 1m0s
[19:40:15.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:139:0)
[19:40:15.045] Timer tick, asking Buildbucket for the build status
[19:40:15.301] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:15.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:140:0) after 1m0s
[19:41:15.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:140:0)
[19:41:15.318] Timer tick, asking Buildbucket for the build status
[19:41:15.607] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:15.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:141:0) after 1m0s
[19:42:15.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:141:0)
[19:42:15.713] Timer tick, asking Buildbucket for the build status
[19:42:15.945] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:15.945] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:142:0) after 1m0s
[19:43:16.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:142:0)
[19:43:16.059] Timer tick, asking Buildbucket for the build status
[19:43:16.655] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:16.655] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:143:0) after 1m0s
[19:44:16.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:143:0)
[19:44:16.733] Timer tick, asking Buildbucket for the build status
[19:44:17.159] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:17.159] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:144:0) after 1m0s
[19:45:17.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:144:0)
[19:45:17.203] Timer tick, asking Buildbucket for the build status
[19:45:17.834] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:17.834] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:145:0) after 1m0s
[19:46:17.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:145:0)
[19:46:17.905] Timer tick, asking Buildbucket for the build status
[19:46:18.441] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:18.441] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:146:0) after 1m0s
[19:47:18.500] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:146:0)
[19:47:18.500] Timer tick, asking Buildbucket for the build status
[19:47:18.905] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:18.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:147:0) after 1m0s
[19:48:18.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:147:0)
[19:48:18.961] Timer tick, asking Buildbucket for the build status
[19:48:19.123] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:19.123] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:148:0) after 1m0s
[19:49:19.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:148:0)
[19:49:19.312] Timer tick, asking Buildbucket for the build status
[19:49:19.612] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:19.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:149:0) after 1m0s
[19:50:19.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:149:0)
[19:50:19.700] Timer tick, asking Buildbucket for the build status
[19:50:20.009] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:20.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:150:0) after 1m0s
[19:51:20.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:150:0)
[19:51:20.237] Timer tick, asking Buildbucket for the build status
[19:51:20.471] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:20.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:151:0) after 1m0s
[19:52:20.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:151:0)
[19:52:20.566] Timer tick, asking Buildbucket for the build status
[19:52:20.732] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:20.732] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:152:0) after 1m0s
[19:53:20.850] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:152:0)
[19:53:20.850] Timer tick, asking Buildbucket for the build status
[19:53:21.067] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:21.067] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:153:0) after 1m0s
[19:54:21.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:153:0)
[19:54:21.186] Timer tick, asking Buildbucket for the build status
[19:54:21.380] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:21.380] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:154:0) after 1m0s
[19:55:21.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:154:0)
[19:55:21.716] Timer tick, asking Buildbucket for the build status
[19:55:21.913] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:21.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:155:0) after 1m0s
[19:56:22.322] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:155:0)
[19:56:22.322] Timer tick, asking Buildbucket for the build status
[19:56:22.519] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:22.519] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:156:0) after 1m0s
[19:57:23.045] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:156:0)
[19:57:23.045] Timer tick, asking Buildbucket for the build status
[19:57:24.000] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:24.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:157:0) after 1m0s
[19:58:24.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:157:0)
[19:58:24.108] Timer tick, asking Buildbucket for the build status
[19:58:24.274] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:24.274] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:158:0) after 1m0s
[19:59:24.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:158:0)
[19:59:24.834] Timer tick, asking Buildbucket for the build status
[19:59:25.035] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:25.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:159:0) after 1m0s
[20:00:25.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:159:0)
[20:00:25.123] Timer tick, asking Buildbucket for the build status
[20:00:25.543] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:25.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:160:0) after 1m0s
[20:01:25.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:160:0)
[20:01:25.673] Timer tick, asking Buildbucket for the build status
[20:01:26.095] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:26.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:161:0) after 1m0s
[20:02:26.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:161:0)
[20:02:26.329] Timer tick, asking Buildbucket for the build status
[20:02:26.492] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:26.492] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:162:0) after 1m0s
[20:03:26.573] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:162:0)
[20:03:26.573] Timer tick, asking Buildbucket for the build status
[20:03:26.812] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:26.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:163:0) after 1m0s
[20:04:26.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:163:0)
[20:04:26.886] Timer tick, asking Buildbucket for the build status
[20:04:27.056] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:27.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:164:0) after 1m0s
[20:05:27.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:164:0)
[20:05:27.153] Timer tick, asking Buildbucket for the build status
[20:05:27.640] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:27.640] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:165:0) after 1m0s
[20:06:27.937] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:165:0)
[20:06:27.937] Timer tick, asking Buildbucket for the build status
[20:06:28.093] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:28.093] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:166:0) after 1m0s
[20:07:28.150] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:166:0)
[20:07:28.150] Timer tick, asking Buildbucket for the build status
[20:07:28.482] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:28.482] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:167:0) after 1m0s
[20:08:28.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:167:0)
[20:08:28.474] Timer tick, asking Buildbucket for the build status
[20:08:28.780] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:28.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:168:0) after 1m0s
[20:09:28.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:168:0)
[20:09:28.930] Timer tick, asking Buildbucket for the build status
[20:09:30.752] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:30.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:169:0) after 1m0s
[20:10:30.863] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:169:0)
[20:10:30.863] Timer tick, asking Buildbucket for the build status
[20:10:31.099] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:31.099] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:170:0) after 1m0s
[20:11:31.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:170:0)
[20:11:31.174] Timer tick, asking Buildbucket for the build status
[20:11:31.349] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:31.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:171:0) after 1m0s
[20:12:31.377] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:171:0)
[20:12:31.377] Timer tick, asking Buildbucket for the build status
[20:12:31.596] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:31.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:172:0) after 1m0s
[20:13:31.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:172:0)
[20:13:31.659] Timer tick, asking Buildbucket for the build status
[20:13:32.143] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:32.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:173:0) after 1m0s
[20:14:32.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:173:0)
[20:14:32.249] Timer tick, asking Buildbucket for the build status
[20:14:32.511] Build 8884111435660996224: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:32.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9049541498004739312:174:0) after 1m0s
[20:14:58.105] Received PubSub notification, asking Buildbucket for the build status
[20:14:58.243] Build 8884111435660996224: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:14:58.243] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1585858497263066",
"created_by": "project:infra",
"created_ts": "1585848121927333",
"id": "8884111435660996224",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4102.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"dbf61594-f4ed-499d-88d6-b226b9ca4bed\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"83.0.4102.3\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$gatekeeper\": {\"group\": \"chromium.infra.cron\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"83.0.4102.3\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"dbf61594-f4ed-499d-88d6-b226b9ca4bed\", \"title\": \"publish_tarball/0\"}]}, \"bot_id\": \"luci-infra-cron-xenial-large-0-1cm1\", \"buildername\": \"Build From Tarball\", \"path_config\": \"generic\", \"recipe\": \"build_from_tarball\", \"version\": \"83.0.4102.3\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-1cm1\"], \"image\": [\"chrome-xenial-20032900-6802ab9ce34\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4926-84b94b1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585848153128053",
"status": "COMPLETED",
"status_changed_ts": "1585858497717875",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9049541498004739312",
"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/8884111435660996224/+/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:4b54bb87c82ed010",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1585858497731515",
"url": "https://ci.chromium.org/b/8884111435660996224",
"utcnow_ts": "1585858498231294"
}
}
[20:14:58.243] Invocation finished in 2h52m57.935708035s with status SUCCEEDED