[17:43:29.692] New invocation is queued and will start shortly
[17:43:29.692] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[17:43:30.866] Starting the invocation (attempt 1)
[17:43:30.926] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:30.926] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:30.927] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9031873737556593968",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4292.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"d6cde6fe-60d7-4df6-ab72-b5cf799c8bfa\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4292.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9031873737556593968",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[17:43:31.750] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1602697411074766",
"id": "8866443675444154464",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4292.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d6cde6fe-60d7-4df6-ab72-b5cf799c8bfa\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4292.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602697411503674",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031873737556593968",
"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/8866443675444154464/+/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": "1602697411503962",
"url": "https://ci.chromium.org/b/8866443675444154464",
"utcnow_ts": "1602697411729877"
}
}
[17:43:31.750] Task URL: https://ci.chromium.org/b/8866443675444154464
[17:43:31.750] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:2:0) after 1m0s
[17:43:39.512] Received PubSub notification, asking Buildbucket for the build status
[17:43:39.928] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:31.841] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:2:0)
[17:44:31.841] Timer tick, asking Buildbucket for the build status
[17:44:31.983] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:31.983] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:4:0) after 1m0s
[17:45:32.038] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:4:0)
[17:45:32.038] Timer tick, asking Buildbucket for the build status
[17:45:32.216] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:32.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:5:0) after 1m0s
[17:46:32.257] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:5:0)
[17:46:32.257] Timer tick, asking Buildbucket for the build status
[17:46:32.430] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:32.430] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:6:0) after 1m0s
[17:47:32.463] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:6:0)
[17:47:32.463] Timer tick, asking Buildbucket for the build status
[17:47:32.708] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:32.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:7:0) after 1m0s
[17:48:32.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:7:0)
[17:48:32.731] Timer tick, asking Buildbucket for the build status
[17:48:32.818] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:32.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:8:0) after 1m0s
[17:49:32.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:8:0)
[17:49:32.846] Timer tick, asking Buildbucket for the build status
[17:49:33.333] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:33.333] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:9:0) after 1m0s
[17:50:33.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:9:0)
[17:50:33.785] Timer tick, asking Buildbucket for the build status
[17:50:34.037] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:34.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:10:0) after 1m0s
[17:51:34.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:10:0)
[17:51:34.979] Timer tick, asking Buildbucket for the build status
[17:51:35.062] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:35.062] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:11:0) after 1m0s
[17:52:35.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:11:0)
[17:52:35.101] Timer tick, asking Buildbucket for the build status
[17:52:35.190] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:35.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:12:0) after 1m0s
[17:53:35.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:12:0)
[17:53:35.280] Timer tick, asking Buildbucket for the build status
[17:53:35.435] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:35.435] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:13:0) after 1m0s
[17:54:35.521] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:13:0)
[17:54:35.521] Timer tick, asking Buildbucket for the build status
[17:54:35.590] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:35.590] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:14:0) after 1m0s
[17:55:35.730] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:14:0)
[17:55:35.730] Timer tick, asking Buildbucket for the build status
[17:55:35.895] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:35.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:15:0) after 1m0s
[17:56:36.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:15:0)
[17:56:36.084] Timer tick, asking Buildbucket for the build status
[17:56:36.233] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:36.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:16:0) after 1m0s
[17:57:36.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:16:0)
[17:57:36.274] Timer tick, asking Buildbucket for the build status
[17:57:36.451] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:36.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:17:0) after 1m0s
[17:58:36.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:17:0)
[17:58:36.530] Timer tick, asking Buildbucket for the build status
[17:58:36.654] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:36.654] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:18:0) after 1m0s
[17:59:36.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:18:0)
[17:59:36.678] Timer tick, asking Buildbucket for the build status
[17:59:36.734] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:36.734] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:19:0) after 1m0s
[18:00:36.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:19:0)
[18:00:36.771] Timer tick, asking Buildbucket for the build status
[18:00:37.094] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:37.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:20:0) after 1m0s
[18:01:37.129] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:20:0)
[18:01:37.129] Timer tick, asking Buildbucket for the build status
[18:01:37.254] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:37.254] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:21:0) after 1m0s
[18:02:37.331] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:21:0)
[18:02:37.331] Timer tick, asking Buildbucket for the build status
[18:02:37.518] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:37.518] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:22:0) after 1m0s
[18:03:37.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:22:0)
[18:03:37.597] Timer tick, asking Buildbucket for the build status
[18:03:38.421] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:38.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:23:0) after 1m0s
[18:04:38.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:23:0)
[18:04:38.541] Timer tick, asking Buildbucket for the build status
[18:04:38.799] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:38.799] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:24:0) after 1m0s
[18:05:38.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:24:0)
[18:05:38.813] Timer tick, asking Buildbucket for the build status
[18:05:38.885] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:38.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:25:0) after 1m0s
[18:06:38.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:25:0)
[18:06:38.929] Timer tick, asking Buildbucket for the build status
[18:06:39.085] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:39.085] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:26:0) after 1m0s
[18:07:39.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:26:0)
[18:07:39.134] Timer tick, asking Buildbucket for the build status
[18:07:39.387] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:39.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:27:0) after 1m0s
[18:08:39.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:27:0)
[18:08:39.441] Timer tick, asking Buildbucket for the build status
[18:08:39.679] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:39.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:28:0) after 1m0s
[18:09:39.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:28:0)
[18:09:39.692] Timer tick, asking Buildbucket for the build status
[18:09:39.760] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:39.760] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:29:0) after 1m0s
[18:10:39.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:29:0)
[18:10:39.883] Timer tick, asking Buildbucket for the build status
[18:10:39.944] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:39.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:30:0) after 1m0s
[18:11:40.095] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:30:0)
[18:11:40.095] Timer tick, asking Buildbucket for the build status
[18:11:40.233] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:40.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:31:0) after 1m0s
[18:12:40.338] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:31:0)
[18:12:40.338] Timer tick, asking Buildbucket for the build status
[18:12:40.585] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:40.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:32:0) after 1m0s
[18:13:40.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:32:0)
[18:13:40.638] Timer tick, asking Buildbucket for the build status
[18:13:41.951] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:41.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:33:0) after 1m0s
[18:14:42.174] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:33:0)
[18:14:42.174] Timer tick, asking Buildbucket for the build status
[18:14:42.249] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:42.249] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:34:0) after 1m0s
[18:15:42.491] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:34:0)
[18:15:42.491] Timer tick, asking Buildbucket for the build status
[18:15:42.567] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:42.567] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:35:0) after 1m0s
[18:16:42.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:35:0)
[18:16:42.705] Timer tick, asking Buildbucket for the build status
[18:16:44.625] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:44.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:36:0) after 1m0s
[18:17:44.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:36:0)
[18:17:44.951] Timer tick, asking Buildbucket for the build status
[18:17:45.088] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:45.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:37:0) after 1m0s
[18:18:45.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:37:0)
[18:18:45.128] Timer tick, asking Buildbucket for the build status
[18:18:45.851] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:45.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:38:0) after 1m0s
[18:19:45.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:38:0)
[18:19:45.986] Timer tick, asking Buildbucket for the build status
[18:19:46.113] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:46.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:39:0) after 1m0s
[18:20:46.164] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:39:0)
[18:20:46.164] Timer tick, asking Buildbucket for the build status
[18:20:46.236] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:46.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:40:0) after 1m0s
[18:21:46.380] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:40:0)
[18:21:46.380] Timer tick, asking Buildbucket for the build status
[18:21:46.461] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:46.461] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:41:0) after 1m0s
[18:22:46.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:41:0)
[18:22:46.593] Timer tick, asking Buildbucket for the build status
[18:22:46.682] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:46.682] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:42:0) after 1m0s
[18:23:46.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:42:0)
[18:23:46.739] Timer tick, asking Buildbucket for the build status
[18:23:46.856] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:46.856] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:43:0) after 1m0s
[18:24:46.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:43:0)
[18:24:46.876] Timer tick, asking Buildbucket for the build status
[18:24:46.964] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:46.964] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:44:0) after 1m0s
[18:25:47.037] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:44:0)
[18:25:47.037] Timer tick, asking Buildbucket for the build status
[18:25:47.104] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:47.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:45:0) after 1m0s
[18:26:47.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:45:0)
[18:26:47.149] Timer tick, asking Buildbucket for the build status
[18:26:47.449] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:47.449] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:46:0) after 1m0s
[18:27:47.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:46:0)
[18:27:47.474] Timer tick, asking Buildbucket for the build status
[18:27:47.533] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:47.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:47:0) after 1m0s
[18:28:47.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:47:0)
[18:28:47.601] Timer tick, asking Buildbucket for the build status
[18:28:47.781] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:47.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:48:0) after 1m0s
[18:29:47.755] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:48:0)
[18:29:47.755] Timer tick, asking Buildbucket for the build status
[18:29:48.001] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:48.001] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:49:0) after 1m0s
[18:30:48.053] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:49:0)
[18:30:48.053] Timer tick, asking Buildbucket for the build status
[18:30:48.143] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:48.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:50:0) after 1m0s
[18:31:48.190] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:50:0)
[18:31:48.190] Timer tick, asking Buildbucket for the build status
[18:31:48.536] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:48.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:51:0) after 1m0s
[18:32:48.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:51:0)
[18:32:48.589] Timer tick, asking Buildbucket for the build status
[18:32:49.086] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:49.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:52:0) after 1m0s
[18:33:49.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:52:0)
[18:33:49.197] Timer tick, asking Buildbucket for the build status
[18:33:49.510] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:49.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:53:0) after 1m0s
[18:34:49.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:53:0)
[18:34:49.557] Timer tick, asking Buildbucket for the build status
[18:34:49.804] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:49.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:54:0) after 1m0s
[18:35:49.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:54:0)
[18:35:49.846] Timer tick, asking Buildbucket for the build status
[18:35:50.126] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:50.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:55:0) after 1m0s
[18:36:50.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:55:0)
[18:36:50.126] Timer tick, asking Buildbucket for the build status
[18:36:50.498] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:50.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:56:0) after 1m0s
[18:37:50.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:56:0)
[18:37:50.588] Timer tick, asking Buildbucket for the build status
[18:37:50.670] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:50.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:57:0) after 1m0s
[18:38:50.717] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:57:0)
[18:38:50.718] Timer tick, asking Buildbucket for the build status
[18:38:50.828] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:50.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:58:0) after 1m0s
[18:39:50.881] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:58:0)
[18:39:50.881] Timer tick, asking Buildbucket for the build status
[18:39:50.972] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:50.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:59:0) after 1m0s
[18:40:51.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:59:0)
[18:40:51.013] Timer tick, asking Buildbucket for the build status
[18:40:51.095] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:51.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:60:0) after 1m0s
[18:41:51.165] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:60:0)
[18:41:51.165] Timer tick, asking Buildbucket for the build status
[18:41:51.328] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:51.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:61:0) after 1m0s
[18:42:51.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:61:0)
[18:42:51.342] Timer tick, asking Buildbucket for the build status
[18:42:51.403] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:51.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:62:0) after 1m0s
[18:43:51.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:62:0)
[18:43:51.420] Timer tick, asking Buildbucket for the build status
[18:43:51.535] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:51.535] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:63:0) after 1m0s
[18:44:51.643] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:63:0)
[18:44:51.643] Timer tick, asking Buildbucket for the build status
[18:44:51.869] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:51.869] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:64:0) after 1m0s
[18:45:51.966] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:64:0)
[18:45:51.966] Timer tick, asking Buildbucket for the build status
[18:45:52.037] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:52.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:65:0) after 1m0s
[18:46:52.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:65:0)
[18:46:52.108] Timer tick, asking Buildbucket for the build status
[18:46:52.199] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:52.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:66:0) after 1m0s
[18:47:52.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:66:0)
[18:47:52.312] Timer tick, asking Buildbucket for the build status
[18:47:52.419] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:52.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:67:0) after 1m0s
[18:48:52.468] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:67:0)
[18:48:52.468] Timer tick, asking Buildbucket for the build status
[18:48:52.597] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:52.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:68:0) after 1m0s
[18:49:52.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:68:0)
[18:49:52.615] Timer tick, asking Buildbucket for the build status
[18:49:52.672] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:52.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:69:0) after 1m0s
[18:50:52.713] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:69:0)
[18:50:52.713] Timer tick, asking Buildbucket for the build status
[18:50:52.810] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:52.810] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:70:0) after 1m0s
[18:51:52.848] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:70:0)
[18:51:52.848] Timer tick, asking Buildbucket for the build status
[18:51:52.935] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:52.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:71:0) after 1m0s
[18:52:53.008] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:71:0)
[18:52:53.008] Timer tick, asking Buildbucket for the build status
[18:52:53.096] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:53.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:72:0) after 1m0s
[18:53:53.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:72:0)
[18:53:53.238] Timer tick, asking Buildbucket for the build status
[18:53:53.363] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:53.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:73:0) after 1m0s
[18:54:53.407] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:73:0)
[18:54:53.407] Timer tick, asking Buildbucket for the build status
[18:54:53.475] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:53.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:74:0) after 1m0s
[18:55:53.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:74:0)
[18:55:53.522] Timer tick, asking Buildbucket for the build status
[18:55:53.588] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:53.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:75:0) after 1m0s
[18:56:53.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:75:0)
[18:56:53.623] Timer tick, asking Buildbucket for the build status
[18:56:53.684] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:53.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:76:0) after 1m0s
[18:57:53.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:76:0)
[18:57:53.813] Timer tick, asking Buildbucket for the build status
[18:57:54.256] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:54.256] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:77:0) after 1m0s
[18:58:54.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:77:0)
[18:58:54.354] Timer tick, asking Buildbucket for the build status
[18:58:54.538] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:54.538] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:78:0) after 1m0s
[18:59:54.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:78:0)
[18:59:54.664] Timer tick, asking Buildbucket for the build status
[18:59:54.787] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:54.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:79:0) after 1m0s
[19:00:54.845] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:79:0)
[19:00:54.845] Timer tick, asking Buildbucket for the build status
[19:00:54.906] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:54.906] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:80:0) after 1m0s
[19:01:55.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:80:0)
[19:01:55.073] Timer tick, asking Buildbucket for the build status
[19:01:55.185] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:55.185] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:81:0) after 1m0s
[19:02:55.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:81:0)
[19:02:55.279] Timer tick, asking Buildbucket for the build status
[19:02:55.402] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:55.402] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:82:0) after 1m0s
[19:03:55.606] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:82:0)
[19:03:55.606] Timer tick, asking Buildbucket for the build status
[19:03:55.758] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:55.758] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:83:0) after 1m0s
[19:04:55.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:83:0)
[19:04:55.907] Timer tick, asking Buildbucket for the build status
[19:04:55.980] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:55.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:84:0) after 1m0s
[19:05:56.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:84:0)
[19:05:56.069] Timer tick, asking Buildbucket for the build status
[19:05:56.408] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:56.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:85:0) after 1m0s
[19:06:56.418] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:85:0)
[19:06:56.418] Timer tick, asking Buildbucket for the build status
[19:06:56.493] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:56.493] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:86:0) after 1m0s
[19:07:56.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:86:0)
[19:07:56.512] Timer tick, asking Buildbucket for the build status
[19:07:56.638] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:56.638] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:87:0) after 1m0s
[19:08:56.667] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:87:0)
[19:08:56.667] Timer tick, asking Buildbucket for the build status
[19:08:56.840] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:56.840] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:88:0) after 1m0s
[19:09:56.929] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:88:0)
[19:09:56.929] Timer tick, asking Buildbucket for the build status
[19:09:57.051] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:57.051] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:89:0) after 1m0s
[19:10:57.083] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:89:0)
[19:10:57.083] Timer tick, asking Buildbucket for the build status
[19:10:57.145] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:57.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:90:0) after 1m0s
[19:11:57.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:90:0)
[19:11:57.195] Timer tick, asking Buildbucket for the build status
[19:11:57.274] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:57.275] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:91:0) after 1m0s
[19:12:57.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:91:0)
[19:12:57.306] Timer tick, asking Buildbucket for the build status
[19:12:58.233] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:58.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:92:0) after 1m0s
[19:13:58.226] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:92:0)
[19:13:58.226] Timer tick, asking Buildbucket for the build status
[19:13:58.359] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:58.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:93:0) after 1m0s
[19:14:58.402] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:93:0)
[19:14:58.402] Timer tick, asking Buildbucket for the build status
[19:14:58.937] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:58.937] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:94:0) after 1m0s
[19:15:59.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:94:0)
[19:15:59.021] Timer tick, asking Buildbucket for the build status
[19:15:59.286] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:59.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:95:0) after 1m0s
[19:16:59.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:95:0)
[19:16:59.312] Timer tick, asking Buildbucket for the build status
[19:16:59.403] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:59.403] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:96:0) after 1m0s
[19:17:59.441] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:96:0)
[19:17:59.441] Timer tick, asking Buildbucket for the build status
[19:17:59.717] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:59.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:97:0) after 1m0s
[19:18:59.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:97:0)
[19:18:59.782] Timer tick, asking Buildbucket for the build status
[19:18:59.920] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:59.921] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:98:0) after 1m0s
[19:19:59.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:98:0)
[19:19:59.927] Timer tick, asking Buildbucket for the build status
[19:20:00.210] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:00.211] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:99:0) after 1m0s
[19:21:00.262] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:99:0)
[19:21:00.262] Timer tick, asking Buildbucket for the build status
[19:21:00.379] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:00.379] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:100:0) after 1m0s
[19:22:00.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:100:0)
[19:22:00.712] Timer tick, asking Buildbucket for the build status
[19:22:00.817] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:00.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:101:0) after 1m0s
[19:23:03.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:101:0)
[19:23:03.229] Timer tick, asking Buildbucket for the build status
[19:23:04.179] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:04.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:102:0) after 1m0s
[19:24:04.563] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:102:0)
[19:24:04.563] Timer tick, asking Buildbucket for the build status
[19:24:04.781] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:04.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:103:0) after 1m0s
[19:25:04.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:103:0)
[19:25:04.821] Timer tick, asking Buildbucket for the build status
[19:25:05.179] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:05.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:104:0) after 1m0s
[19:26:05.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:104:0)
[19:26:05.173] Timer tick, asking Buildbucket for the build status
[19:26:05.257] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:05.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:105:0) after 1m0s
[19:27:05.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:105:0)
[19:27:05.279] Timer tick, asking Buildbucket for the build status
[19:27:05.369] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:05.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:106:0) after 1m0s
[19:28:05.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:106:0)
[19:28:05.403] Timer tick, asking Buildbucket for the build status
[19:28:05.547] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:05.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:107:0) after 1m0s
[19:29:05.628] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:107:0)
[19:29:05.628] Timer tick, asking Buildbucket for the build status
[19:29:06.451] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:06.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:108:0) after 1m0s
[19:30:06.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:108:0)
[19:30:06.517] Timer tick, asking Buildbucket for the build status
[19:30:06.604] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:06.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:109:0) after 1m0s
[19:31:06.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:109:0)
[19:31:06.703] Timer tick, asking Buildbucket for the build status
[19:31:06.780] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:06.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:110:0) after 1m0s
[19:32:06.892] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:110:0)
[19:32:06.892] Timer tick, asking Buildbucket for the build status
[19:32:07.240] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:07.240] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:111:0) after 1m0s
[19:33:07.314] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:111:0)
[19:33:07.314] Timer tick, asking Buildbucket for the build status
[19:33:07.416] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:07.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:112:0) after 1m0s
[19:34:07.459] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:112:0)
[19:34:07.459] Timer tick, asking Buildbucket for the build status
[19:34:07.601] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:07.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:113:0) after 1m0s
[19:35:07.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:113:0)
[19:35:07.645] Timer tick, asking Buildbucket for the build status
[19:35:07.714] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:07.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:114:0) after 1m0s
[19:36:07.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:114:0)
[19:36:07.789] Timer tick, asking Buildbucket for the build status
[19:36:07.910] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:07.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:115:0) after 1m0s
[19:37:07.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:115:0)
[19:37:07.958] Timer tick, asking Buildbucket for the build status
[19:37:08.086] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:08.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:116:0) after 1m0s
[19:38:08.120] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:116:0)
[19:38:08.120] Timer tick, asking Buildbucket for the build status
[19:38:08.207] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:08.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:117:0) after 1m0s
[19:39:08.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:117:0)
[19:39:08.231] Timer tick, asking Buildbucket for the build status
[19:39:08.412] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:08.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:118:0) after 1m0s
[19:40:08.428] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:118:0)
[19:40:08.428] Timer tick, asking Buildbucket for the build status
[19:40:08.529] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:08.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:119:0) after 1m0s
[19:41:08.544] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:119:0)
[19:41:08.544] Timer tick, asking Buildbucket for the build status
[19:41:08.617] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:08.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:120:0) after 1m0s
[19:42:08.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:120:0)
[19:42:08.653] Timer tick, asking Buildbucket for the build status
[19:42:08.715] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:08.715] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:121:0) after 1m0s
[19:43:08.736] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:121:0)
[19:43:08.736] Timer tick, asking Buildbucket for the build status
[19:43:08.802] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:08.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:122:0) after 1m0s
[19:44:08.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:122:0)
[19:44:08.833] Timer tick, asking Buildbucket for the build status
[19:44:09.031] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:09.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:123:0) after 1m0s
[19:45:09.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:123:0)
[19:45:09.057] Timer tick, asking Buildbucket for the build status
[19:45:09.176] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:09.176] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:124:0) after 1m0s
[19:46:09.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:124:0)
[19:46:09.205] Timer tick, asking Buildbucket for the build status
[19:46:09.278] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:09.278] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:125:0) after 1m0s
[19:47:09.474] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:125:0)
[19:47:09.474] Timer tick, asking Buildbucket for the build status
[19:47:09.782] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:09.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:126:0) after 1m0s
[19:48:09.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:126:0)
[19:48:09.843] Timer tick, asking Buildbucket for the build status
[19:48:09.995] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:09.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:127:0) after 1m0s
[19:49:10.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:127:0)
[19:49:10.108] Timer tick, asking Buildbucket for the build status
[19:49:10.685] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:10.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:128:0) after 1m0s
[19:50:10.781] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:128:0)
[19:50:10.781] Timer tick, asking Buildbucket for the build status
[19:50:10.877] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:10.877] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:129:0) after 1m0s
[19:51:10.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:129:0)
[19:51:10.983] Timer tick, asking Buildbucket for the build status
[19:51:11.100] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:11.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:130:0) after 1m0s
[19:52:11.145] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:130:0)
[19:52:11.145] Timer tick, asking Buildbucket for the build status
[19:52:11.401] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:11.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:131:0) after 1m0s
[19:53:11.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:131:0)
[19:53:11.448] Timer tick, asking Buildbucket for the build status
[19:53:11.513] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:11.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:132:0) after 1m0s
[19:54:11.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:132:0)
[19:54:11.561] Timer tick, asking Buildbucket for the build status
[19:54:11.874] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:11.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:133:0) after 1m0s
[19:55:11.927] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:133:0)
[19:55:11.927] Timer tick, asking Buildbucket for the build status
[19:55:12.006] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:12.006] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:134:0) after 1m0s
[19:56:12.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:134:0)
[19:56:12.033] Timer tick, asking Buildbucket for the build status
[19:56:12.389] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:12.389] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:135:0) after 1m0s
[19:57:12.372] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:135:0)
[19:57:12.372] Timer tick, asking Buildbucket for the build status
[19:57:12.903] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:12.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:136:0) after 1m0s
[19:58:12.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:136:0)
[19:58:12.970] Timer tick, asking Buildbucket for the build status
[19:58:13.686] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:13.686] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:137:0) after 1m0s
[19:59:13.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:137:0)
[19:59:13.678] Timer tick, asking Buildbucket for the build status
[19:59:13.784] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:13.784] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:138:0) after 1m0s
[20:00:13.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:138:0)
[20:00:13.818] Timer tick, asking Buildbucket for the build status
[20:00:14.532] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:14.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:139:0) after 1m0s
[20:01:14.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:139:0)
[20:01:14.561] Timer tick, asking Buildbucket for the build status
[20:01:14.620] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:14.620] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:140:0) after 1m0s
[20:02:14.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:140:0)
[20:02:14.691] Timer tick, asking Buildbucket for the build status
[20:02:14.874] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:14.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:141:0) after 1m0s
[20:03:14.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:141:0)
[20:03:14.953] Timer tick, asking Buildbucket for the build status
[20:03:15.056] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:15.056] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:142:0) after 1m0s
[20:04:15.088] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:142:0)
[20:04:15.088] Timer tick, asking Buildbucket for the build status
[20:04:15.844] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:15.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:143:0) after 1m0s
[20:05:15.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:143:0)
[20:05:15.914] Timer tick, asking Buildbucket for the build status
[20:05:16.005] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:16.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:144:0) after 1m0s
[20:06:16.033] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:144:0)
[20:06:16.033] Timer tick, asking Buildbucket for the build status
[20:06:16.137] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:16.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:145:0) after 1m0s
[20:07:16.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:145:0)
[20:07:16.162] Timer tick, asking Buildbucket for the build status
[20:07:16.237] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:16.237] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:146:0) after 1m0s
[20:08:16.264] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:146:0)
[20:08:16.264] Timer tick, asking Buildbucket for the build status
[20:08:16.360] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:16.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:147:0) after 1m0s
[20:09:16.385] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:147:0)
[20:09:16.385] Timer tick, asking Buildbucket for the build status
[20:09:16.684] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:16.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:148:0) after 1m0s
[20:10:16.690] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:148:0)
[20:10:16.690] Timer tick, asking Buildbucket for the build status
[20:10:16.761] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:16.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:149:0) after 1m0s
[20:11:16.778] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:149:0)
[20:11:16.778] Timer tick, asking Buildbucket for the build status
[20:11:16.935] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:16.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:150:0) after 1m0s
[20:12:17.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:150:0)
[20:12:17.572] Timer tick, asking Buildbucket for the build status
[20:12:17.633] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:17.633] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:151:0) after 1m0s
[20:13:17.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:151:0)
[20:13:17.776] Timer tick, asking Buildbucket for the build status
[20:13:17.849] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:17.849] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:152:0) after 1m0s
[20:14:18.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:152:0)
[20:14:18.093] Timer tick, asking Buildbucket for the build status
[20:14:18.213] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:18.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:153:0) after 1m0s
[20:15:18.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:153:0)
[20:15:18.509] Timer tick, asking Buildbucket for the build status
[20:15:19.031] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:19.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:154:0) after 1m0s
[20:16:19.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:154:0)
[20:16:19.414] Timer tick, asking Buildbucket for the build status
[20:16:19.488] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:19.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:155:0) after 1m0s
[20:17:19.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:155:0)
[20:17:19.627] Timer tick, asking Buildbucket for the build status
[20:17:19.693] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:19.693] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:156:0) after 1m0s
[20:18:19.732] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:156:0)
[20:18:19.732] Timer tick, asking Buildbucket for the build status
[20:18:19.979] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:19.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:157:0) after 1m0s
[20:19:20.672] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:157:0)
[20:19:20.672] Timer tick, asking Buildbucket for the build status
[20:19:20.804] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:20.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:158:0) after 1m0s
[20:20:20.983] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:158:0)
[20:20:20.983] Timer tick, asking Buildbucket for the build status
[20:20:21.561] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:21.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:159:0) after 1m0s
[20:21:21.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:159:0)
[20:21:21.547] Timer tick, asking Buildbucket for the build status
[20:21:21.618] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:21.618] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:160:0) after 1m0s
[20:22:21.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:160:0)
[20:22:21.783] Timer tick, asking Buildbucket for the build status
[20:22:21.844] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:21.844] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:161:0) after 1m0s
[20:23:21.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:161:0)
[20:23:21.883] Timer tick, asking Buildbucket for the build status
[20:23:22.098] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:22.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:162:0) after 1m0s
[20:24:22.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:162:0)
[20:24:22.138] Timer tick, asking Buildbucket for the build status
[20:24:22.387] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:22.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:163:0) after 1m0s
[20:25:22.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:163:0)
[20:25:22.548] Timer tick, asking Buildbucket for the build status
[20:25:22.621] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:22.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:164:0) after 1m0s
[20:26:22.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:164:0)
[20:26:22.735] Timer tick, asking Buildbucket for the build status
[20:26:23.165] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:23.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:165:0) after 1m0s
[20:27:23.291] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:165:0)
[20:27:23.291] Timer tick, asking Buildbucket for the build status
[20:27:23.362] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:23.362] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:166:0) after 1m0s
[20:28:23.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:166:0)
[20:28:23.383] Timer tick, asking Buildbucket for the build status
[20:28:23.506] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:23.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:167:0) after 1m0s
[20:29:23.634] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:167:0)
[20:29:23.634] Timer tick, asking Buildbucket for the build status
[20:29:23.767] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:23.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:168:0) after 1m0s
[20:30:23.816] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:168:0)
[20:30:23.816] Timer tick, asking Buildbucket for the build status
[20:30:23.894] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:23.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:169:0) after 1m0s
[20:31:23.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:169:0)
[20:31:23.961] Timer tick, asking Buildbucket for the build status
[20:31:24.055] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:24.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:170:0) after 1m0s
[20:32:24.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:170:0)
[20:32:24.125] Timer tick, asking Buildbucket for the build status
[20:32:24.400] Build 8866443675444154464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:24.400] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9031873737556593968:171:0) after 1m0s
[20:33:19.684] Received PubSub notification, asking Buildbucket for the build status
[20:33:19.778] Build 8866443675444154464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:33:19.778] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1602707598692970",
"created_by": "project:infra",
"created_ts": "1602697411074766",
"id": "8866443675444154464",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4292.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"d6cde6fe-60d7-4df6-ab72-b5cf799c8bfa\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4292.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4d1db109d30b9f0068cf0464722c703e05f788cd82e2d29876a9483818e7c333_v2\", \"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-huhs\"], \"image\": [\"chrome-xenial-20101200-4a97c2da996\"], \"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\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602697417296346",
"status": "COMPLETED",
"status_changed_ts": "1602707599196732",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9031873737556593968",
"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/8866443675444154464/+/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:4f41074996cfc310",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1602707599211787",
"url": "https://ci.chromium.org/b/8866443675444154464",
"utcnow_ts": "1602707599767962"
}
}
[20:33:19.778] Invocation finished in 2h49m50.10206932s with status SUCCEEDED