[11:21:13.466] New invocation is queued and will start shortly
[11:21:13.466] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[11:21:14.586] Starting the invocation (attempt 1)
[11:21:14.624] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:21:14.624] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:21:14.624] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9032350772764021984",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4287.0\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"3788c733-6f47-416e-b9b2-fa8ed8742077\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4287.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:9032350772764021984",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[11:21:15.082] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1602242474782176",
"id": "8866920710721057984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4287.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3788c733-6f47-416e-b9b2-fa8ed8742077\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4287.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602242474953832",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9032350772764021984",
"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/8866920710721057984/+/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": "1602242474953942",
"url": "https://ci.chromium.org/b/8866920710721057984",
"utcnow_ts": "1602242475073771"
}
}
[11:21:15.082] Task URL: https://ci.chromium.org/b/8866920710721057984
[11:21:15.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:2:0) after 1m0s
[11:21:33.147] Received PubSub notification, asking Buildbucket for the build status
[11:21:33.248] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:15.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:2:0)
[11:22:15.114] Timer tick, asking Buildbucket for the build status
[11:22:17.453] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:17.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:4:0) after 1m0s
[11:23:17.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:4:0)
[11:23:17.499] Timer tick, asking Buildbucket for the build status
[11:23:17.801] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:17.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:5:0) after 1m0s
[11:24:17.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:5:0)
[11:24:17.823] Timer tick, asking Buildbucket for the build status
[11:24:17.935] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:17.935] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:6:0) after 1m0s
[11:25:17.958] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:6:0)
[11:25:17.958] Timer tick, asking Buildbucket for the build status
[11:25:18.118] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:18.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:7:0) after 1m0s
[11:26:18.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:7:0)
[11:26:18.138] Timer tick, asking Buildbucket for the build status
[11:26:18.549] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:18.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:8:0) after 1m0s
[11:27:18.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:8:0)
[11:27:18.648] Timer tick, asking Buildbucket for the build status
[11:27:18.804] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:18.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:9:0) after 1m0s
[11:28:18.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:9:0)
[11:28:18.815] Timer tick, asking Buildbucket for the build status
[11:28:18.890] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:18.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:10:0) after 1m0s
[11:29:18.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:10:0)
[11:29:18.879] Timer tick, asking Buildbucket for the build status
[11:29:18.944] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:18.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:11:0) after 1m0s
[11:30:18.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:11:0)
[11:30:18.974] Timer tick, asking Buildbucket for the build status
[11:30:19.053] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:19.053] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:12:0) after 1m0s
[11:31:19.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:12:0)
[11:31:19.039] Timer tick, asking Buildbucket for the build status
[11:31:19.135] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:19.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:13:0) after 1m0s
[11:32:19.153] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:13:0)
[11:32:19.153] Timer tick, asking Buildbucket for the build status
[11:32:19.222] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:19.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:14:0) after 1m0s
[11:33:19.243] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:14:0)
[11:33:19.243] Timer tick, asking Buildbucket for the build status
[11:33:19.326] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:19.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:15:0) after 1m0s
[11:34:19.352] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:15:0)
[11:34:19.352] Timer tick, asking Buildbucket for the build status
[11:34:19.412] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:19.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:16:0) after 1m0s
[11:35:19.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:16:0)
[11:35:19.420] Timer tick, asking Buildbucket for the build status
[11:35:19.484] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:19.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:17:0) after 1m0s
[11:36:19.550] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:17:0)
[11:36:19.550] Timer tick, asking Buildbucket for the build status
[11:36:19.649] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:19.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:18:0) after 1m0s
[11:37:19.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:18:0)
[11:37:19.664] Timer tick, asking Buildbucket for the build status
[11:37:19.904] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:19.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:19:0) after 1m0s
[11:38:20.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:19:0)
[11:38:20.026] Timer tick, asking Buildbucket for the build status
[11:38:20.119] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:20.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:20:0) after 1m0s
[11:39:20.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:20:0)
[11:39:20.131] Timer tick, asking Buildbucket for the build status
[11:39:20.393] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:20.393] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:21:0) after 1m0s
[11:40:20.450] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:21:0)
[11:40:20.450] Timer tick, asking Buildbucket for the build status
[11:40:20.716] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:20.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:22:0) after 1m0s
[11:41:20.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:22:0)
[11:41:20.777] Timer tick, asking Buildbucket for the build status
[11:41:21.081] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:21.081] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:23:0) after 1m0s
[11:42:21.117] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:23:0)
[11:42:21.117] Timer tick, asking Buildbucket for the build status
[11:42:21.202] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:21.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:24:0) after 1m0s
[11:43:21.245] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:24:0)
[11:43:21.245] Timer tick, asking Buildbucket for the build status
[11:43:21.417] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:21.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:25:0) after 1m0s
[11:44:21.414] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:25:0)
[11:44:21.414] Timer tick, asking Buildbucket for the build status
[11:44:21.912] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:21.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:26:0) after 1m0s
[11:45:21.974] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:26:0)
[11:45:21.974] Timer tick, asking Buildbucket for the build status
[11:45:22.079] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:22.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:27:0) after 1m0s
[11:46:22.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:27:0)
[11:46:22.107] Timer tick, asking Buildbucket for the build status
[11:46:22.408] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:22.408] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:28:0) after 1m0s
[11:47:22.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:28:0)
[11:47:22.438] Timer tick, asking Buildbucket for the build status
[11:47:22.509] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:22.509] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:29:0) after 1m0s
[11:48:22.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:29:0)
[11:48:22.529] Timer tick, asking Buildbucket for the build status
[11:48:22.724] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:22.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:30:0) after 1m0s
[11:49:22.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:30:0)
[11:49:22.715] Timer tick, asking Buildbucket for the build status
[11:49:22.781] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:22.781] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:31:0) after 1m0s
[11:50:22.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:31:0)
[11:50:22.808] Timer tick, asking Buildbucket for the build status
[11:50:22.870] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:22.870] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:32:0) after 1m0s
[11:51:22.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:32:0)
[11:51:22.903] Timer tick, asking Buildbucket for the build status
[11:51:23.017] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:23.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:33:0) after 1m0s
[11:52:23.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:33:0)
[11:52:23.084] Timer tick, asking Buildbucket for the build status
[11:52:23.147] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:23.147] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:34:0) after 1m0s
[11:53:23.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:34:0)
[11:53:23.173] Timer tick, asking Buildbucket for the build status
[11:53:23.250] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:23.250] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:35:0) after 1m0s
[11:54:23.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:35:0)
[11:54:23.272] Timer tick, asking Buildbucket for the build status
[11:54:23.342] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:23.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:36:0) after 1m0s
[11:55:23.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:36:0)
[11:55:23.524] Timer tick, asking Buildbucket for the build status
[11:55:23.681] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:23.681] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:37:0) after 1m0s
[11:56:23.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:37:0)
[11:56:23.961] Timer tick, asking Buildbucket for the build status
[11:56:24.087] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:24.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:38:0) after 1m0s
[11:57:24.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:38:0)
[11:57:24.131] Timer tick, asking Buildbucket for the build status
[11:57:24.245] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:24.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:39:0) after 1m0s
[11:58:24.397] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:39:0)
[11:58:24.397] Timer tick, asking Buildbucket for the build status
[11:58:24.467] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:24.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:40:0) after 1m0s
[11:59:24.704] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:40:0)
[11:59:24.704] Timer tick, asking Buildbucket for the build status
[11:59:24.797] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:24.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:41:0) after 1m0s
[12:00:24.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:41:0)
[12:00:24.886] Timer tick, asking Buildbucket for the build status
[12:00:24.946] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:24.946] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:42:0) after 1m0s
[12:01:25.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:42:0)
[12:01:25.205] Timer tick, asking Buildbucket for the build status
[12:01:25.326] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:25.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:43:0) after 1m0s
[12:02:25.457] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:43:0)
[12:02:25.458] Timer tick, asking Buildbucket for the build status
[12:02:25.536] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:25.536] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:44:0) after 1m0s
[12:03:25.748] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:44:0)
[12:03:25.748] Timer tick, asking Buildbucket for the build status
[12:03:25.818] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:25.818] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:45:0) after 1m0s
[12:04:26.141] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:45:0)
[12:04:26.141] Timer tick, asking Buildbucket for the build status
[12:04:26.316] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:26.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:46:0) after 1m0s
[12:05:26.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:46:0)
[12:05:26.446] Timer tick, asking Buildbucket for the build status
[12:05:26.510] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:26.510] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:47:0) after 1m0s
[12:06:26.538] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:47:0)
[12:06:26.538] Timer tick, asking Buildbucket for the build status
[12:06:26.676] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:26.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:48:0) after 1m0s
[12:07:26.749] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:48:0)
[12:07:26.749] Timer tick, asking Buildbucket for the build status
[12:07:26.811] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:26.811] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:49:0) after 1m0s
[12:08:26.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:49:0)
[12:08:26.876] Timer tick, asking Buildbucket for the build status
[12:08:27.002] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:27.002] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:50:0) after 1m0s
[12:09:27.039] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:50:0)
[12:09:27.039] Timer tick, asking Buildbucket for the build status
[12:09:27.224] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:27.224] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:51:0) after 1m0s
[12:10:27.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:51:0)
[12:10:27.295] Timer tick, asking Buildbucket for the build status
[12:10:27.386] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:27.386] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:52:0) after 1m0s
[12:11:27.460] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:52:0)
[12:11:27.460] Timer tick, asking Buildbucket for the build status
[12:11:27.597] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:27.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:53:0) after 1m0s
[12:12:27.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:53:0)
[12:12:27.680] Timer tick, asking Buildbucket for the build status
[12:12:27.788] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:27.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:54:0) after 1m0s
[12:13:27.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:54:0)
[12:13:27.886] Timer tick, asking Buildbucket for the build status
[12:13:27.986] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:27.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:55:0) after 1m0s
[12:14:28.023] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:55:0)
[12:14:28.024] Timer tick, asking Buildbucket for the build status
[12:14:28.089] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:28.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:56:0) after 1m0s
[12:15:28.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:56:0)
[12:15:28.265] Timer tick, asking Buildbucket for the build status
[12:15:28.346] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:28.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:57:0) after 1m0s
[12:16:28.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:57:0)
[12:16:28.930] Timer tick, asking Buildbucket for the build status
[12:16:29.125] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.125] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:58:0) after 1m0s
[12:17:29.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:58:0)
[12:17:29.207] Timer tick, asking Buildbucket for the build status
[12:17:29.271] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:59:0) after 1m0s
[12:18:29.324] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:59:0)
[12:18:29.324] Timer tick, asking Buildbucket for the build status
[12:18:29.387] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:29.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:60:0) after 1m0s
[12:19:29.481] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:60:0)
[12:19:29.481] Timer tick, asking Buildbucket for the build status
[12:19:29.599] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:29.599] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:61:0) after 1m0s
[12:20:29.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:61:0)
[12:20:29.655] Timer tick, asking Buildbucket for the build status
[12:20:30.223] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:62:0) after 1m0s
[12:21:30.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:62:0)
[12:21:30.271] Timer tick, asking Buildbucket for the build status
[12:21:30.766] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:63:0) after 1m0s
[12:22:30.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:63:0)
[12:22:30.820] Timer tick, asking Buildbucket for the build status
[12:22:30.867] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:30.867] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:64:0) after 1m0s
[12:23:30.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:64:0)
[12:23:30.886] Timer tick, asking Buildbucket for the build status
[12:23:30.959] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:30.959] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:65:0) after 1m0s
[12:24:31.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:65:0)
[12:24:31.122] Timer tick, asking Buildbucket for the build status
[12:24:31.183] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:31.183] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:66:0) after 1m0s
[12:25:31.304] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:66:0)
[12:25:31.304] Timer tick, asking Buildbucket for the build status
[12:25:31.506] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:31.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:67:0) after 1m0s
[12:26:31.549] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:67:0)
[12:26:31.549] Timer tick, asking Buildbucket for the build status
[12:26:31.673] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:31.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:68:0) after 1m0s
[12:27:31.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:68:0)
[12:27:31.815] Timer tick, asking Buildbucket for the build status
[12:27:31.873] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:31.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:69:0) after 1m0s
[12:28:31.928] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:69:0)
[12:28:31.928] Timer tick, asking Buildbucket for the build status
[12:28:32.203] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:32.203] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:70:0) after 1m0s
[12:29:32.325] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:70:0)
[12:29:32.325] Timer tick, asking Buildbucket for the build status
[12:29:32.420] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:32.420] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:71:0) after 1m0s
[12:30:32.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:71:0)
[12:30:32.514] Timer tick, asking Buildbucket for the build status
[12:30:32.577] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:32.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:72:0) after 1m0s
[12:31:32.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:72:0)
[12:31:32.582] Timer tick, asking Buildbucket for the build status
[12:31:32.679] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:32.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:73:0) after 1m0s
[12:32:32.780] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:73:0)
[12:32:32.780] Timer tick, asking Buildbucket for the build status
[12:32:32.874] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:32.874] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:74:0) after 1m0s
[12:33:32.934] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:74:0)
[12:33:32.934] Timer tick, asking Buildbucket for the build status
[12:33:33.111] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:33.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:75:0) after 1m0s
[12:34:33.207] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:75:0)
[12:34:33.207] Timer tick, asking Buildbucket for the build status
[12:34:33.395] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:33.395] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:76:0) after 1m0s
[12:35:33.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:76:0)
[12:35:33.447] Timer tick, asking Buildbucket for the build status
[12:35:33.513] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:33.513] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:77:0) after 1m0s
[12:36:33.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:77:0)
[12:36:33.632] Timer tick, asking Buildbucket for the build status
[12:36:33.980] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:33.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:78:0) after 1m0s
[12:37:34.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:78:0)
[12:37:34.069] Timer tick, asking Buildbucket for the build status
[12:37:34.148] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:34.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:79:0) after 1m0s
[12:38:34.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:79:0)
[12:38:34.274] Timer tick, asking Buildbucket for the build status
[12:38:34.780] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:34.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:80:0) after 1m0s
[12:39:34.955] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:80:0)
[12:39:34.955] Timer tick, asking Buildbucket for the build status
[12:39:35.036] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:35.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:81:0) after 1m0s
[12:40:35.196] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:81:0)
[12:40:35.196] Timer tick, asking Buildbucket for the build status
[12:40:35.385] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:35.385] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:82:0) after 1m0s
[12:41:35.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:82:0)
[12:41:35.540] Timer tick, asking Buildbucket for the build status
[12:41:35.657] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:35.657] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:83:0) after 1m0s
[12:42:35.794] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:83:0)
[12:42:35.794] Timer tick, asking Buildbucket for the build status
[12:42:36.286] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:36.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:84:0) after 1m0s
[12:43:36.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:84:0)
[12:43:36.336] Timer tick, asking Buildbucket for the build status
[12:43:36.511] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:36.511] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:85:0) after 1m0s
[12:44:36.591] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:85:0)
[12:44:36.591] Timer tick, asking Buildbucket for the build status
[12:44:36.676] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:36.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:86:0) after 1m0s
[12:45:36.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:86:0)
[12:45:36.769] Timer tick, asking Buildbucket for the build status
[12:45:36.837] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:36.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:87:0) after 1m0s
[12:46:36.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:87:0)
[12:46:36.935] Timer tick, asking Buildbucket for the build status
[12:46:37.044] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.044] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:88:0) after 1m0s
[12:47:37.173] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:88:0)
[12:47:37.173] Timer tick, asking Buildbucket for the build status
[12:47:37.303] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:37.303] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:89:0) after 1m0s
[12:48:37.336] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:89:0)
[12:48:37.336] Timer tick, asking Buildbucket for the build status
[12:48:37.404] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:37.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:90:0) after 1m0s
[12:49:37.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:90:0)
[12:49:37.403] Timer tick, asking Buildbucket for the build status
[12:49:37.463] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:37.463] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:91:0) after 1m0s
[12:50:37.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:91:0)
[12:50:37.517] Timer tick, asking Buildbucket for the build status
[12:50:37.595] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:37.595] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:92:0) after 1m0s
[12:51:37.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:92:0)
[12:51:37.615] Timer tick, asking Buildbucket for the build status
[12:51:37.716] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:37.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:93:0) after 1m0s
[12:52:37.785] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:93:0)
[12:52:37.785] Timer tick, asking Buildbucket for the build status
[12:52:37.846] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:37.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:94:0) after 1m0s
[12:53:37.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:94:0)
[12:53:37.988] Timer tick, asking Buildbucket for the build status
[12:53:38.058] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:38.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:95:0) after 1m0s
[12:54:38.166] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:95:0)
[12:54:38.166] Timer tick, asking Buildbucket for the build status
[12:54:38.252] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:38.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:96:0) after 1m0s
[12:55:38.339] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:96:0)
[12:55:38.339] Timer tick, asking Buildbucket for the build status
[12:55:38.619] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:38.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:97:0) after 1m0s
[12:56:38.678] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:97:0)
[12:56:38.678] Timer tick, asking Buildbucket for the build status
[12:56:38.788] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:38.788] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:98:0) after 1m0s
[12:57:38.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:98:0)
[12:57:38.784] Timer tick, asking Buildbucket for the build status
[12:57:38.850] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:38.850] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:99:0) after 1m0s
[12:58:38.915] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:99:0)
[12:58:38.915] Timer tick, asking Buildbucket for the build status
[12:58:38.990] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:38.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:100:0) after 1m0s
[12:59:39.138] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:100:0)
[12:59:39.138] Timer tick, asking Buildbucket for the build status
[12:59:39.257] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:39.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:101:0) after 1m0s
[13:00:39.599] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:101:0)
[13:00:39.599] Timer tick, asking Buildbucket for the build status
[13:00:40.490] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:40.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:102:0) after 1m0s
[13:01:40.722] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:102:0)
[13:01:40.722] Timer tick, asking Buildbucket for the build status
[13:01:40.854] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:40.854] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:103:0) after 1m0s
[13:02:40.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:103:0)
[13:02:40.951] Timer tick, asking Buildbucket for the build status
[13:02:41.035] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:41.035] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:104:0) after 1m0s
[13:03:41.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:104:0)
[13:03:41.096] Timer tick, asking Buildbucket for the build status
[13:03:41.164] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:41.164] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:105:0) after 1m0s
[13:04:41.317] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:105:0)
[13:04:41.317] Timer tick, asking Buildbucket for the build status
[13:04:41.755] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:41.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:106:0) after 1m0s
[13:05:41.919] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:106:0)
[13:05:41.919] Timer tick, asking Buildbucket for the build status
[13:05:41.992] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:41.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:107:0) after 1m0s
[13:06:42.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:107:0)
[13:06:42.198] Timer tick, asking Buildbucket for the build status
[13:06:42.313] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:42.313] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:108:0) after 1m0s
[13:07:45.127] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:108:0)
[13:07:45.127] Timer tick, asking Buildbucket for the build status
[13:07:45.221] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:45.221] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:109:0) after 1m0s
[13:08:45.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:109:0)
[13:08:45.256] Timer tick, asking Buildbucket for the build status
[13:08:45.328] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:45.328] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:110:0) after 1m0s
[13:09:45.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:110:0)
[13:09:45.405] Timer tick, asking Buildbucket for the build status
[13:09:45.500] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:45.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:111:0) after 1m0s
[13:10:45.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:111:0)
[13:10:45.530] Timer tick, asking Buildbucket for the build status
[13:10:46.009] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:46.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:112:0) after 1m0s
[13:11:45.994] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:112:0)
[13:11:45.994] Timer tick, asking Buildbucket for the build status
[13:11:46.091] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:46.091] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:113:0) after 1m0s
[13:12:46.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:113:0)
[13:12:46.195] Timer tick, asking Buildbucket for the build status
[13:12:46.252] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:46.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:114:0) after 1m0s
[13:13:46.419] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:114:0)
[13:13:46.419] Timer tick, asking Buildbucket for the build status
[13:13:46.481] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:46.481] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:115:0) after 1m0s
[13:14:46.530] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:115:0)
[13:14:46.530] Timer tick, asking Buildbucket for the build status
[13:14:46.597] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:46.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:116:0) after 1m0s
[13:15:46.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:116:0)
[13:15:46.625] Timer tick, asking Buildbucket for the build status
[13:15:46.725] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:46.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:117:0) after 1m0s
[13:16:46.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:117:0)
[13:16:46.771] Timer tick, asking Buildbucket for the build status
[13:16:46.888] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:46.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:118:0) after 1m0s
[13:17:47.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:118:0)
[13:17:47.010] Timer tick, asking Buildbucket for the build status
[13:17:47.075] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:47.075] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:119:0) after 1m0s
[13:18:47.212] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:119:0)
[13:18:47.212] Timer tick, asking Buildbucket for the build status
[13:18:47.276] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:47.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:120:0) after 1m0s
[13:19:47.420] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:120:0)
[13:19:47.420] Timer tick, asking Buildbucket for the build status
[13:19:47.600] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:47.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:121:0) after 1m0s
[13:20:47.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:121:0)
[13:20:47.680] Timer tick, asking Buildbucket for the build status
[13:20:47.751] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:47.752] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:122:0) after 1m0s
[13:21:47.825] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:122:0)
[13:21:47.825] Timer tick, asking Buildbucket for the build status
[13:21:47.963] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:47.963] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:123:0) after 1m0s
[13:22:48.010] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:123:0)
[13:22:48.010] Timer tick, asking Buildbucket for the build status
[13:22:48.082] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:48.082] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:124:0) after 1m0s
[13:23:48.265] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:124:0)
[13:23:48.265] Timer tick, asking Buildbucket for the build status
[13:23:48.419] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:48.419] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:125:0) after 1m0s
[13:24:48.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:125:0)
[13:24:48.577] Timer tick, asking Buildbucket for the build status
[13:24:48.641] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:48.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:126:0) after 1m0s
[13:25:48.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:126:0)
[13:25:48.832] Timer tick, asking Buildbucket for the build status
[13:25:48.893] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:48.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:127:0) after 1m0s
[13:26:48.880] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:127:0)
[13:26:48.880] Timer tick, asking Buildbucket for the build status
[13:26:49.000] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:49.000] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:128:0) after 1m0s
[13:27:49.025] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:128:0)
[13:27:49.025] Timer tick, asking Buildbucket for the build status
[13:27:49.104] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:49.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:129:0) after 1m0s
[13:28:49.232] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:129:0)
[13:28:49.232] Timer tick, asking Buildbucket for the build status
[13:28:49.375] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:49.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:130:0) after 1m0s
[13:29:49.405] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:130:0)
[13:29:49.405] Timer tick, asking Buildbucket for the build status
[13:29:49.464] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:49.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:131:0) after 1m0s
[13:30:49.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:131:0)
[13:30:49.557] Timer tick, asking Buildbucket for the build status
[13:30:49.711] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:49.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:132:0) after 1m0s
[13:31:49.759] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:132:0)
[13:31:49.759] Timer tick, asking Buildbucket for the build status
[13:31:49.893] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:49.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:133:0) after 1m0s
[13:32:49.900] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:133:0)
[13:32:49.900] Timer tick, asking Buildbucket for the build status
[13:32:49.985] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:49.985] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:134:0) after 1m0s
[13:33:50.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:134:0)
[13:33:50.056] Timer tick, asking Buildbucket for the build status
[13:33:50.135] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:50.135] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:135:0) after 1m0s
[13:34:50.273] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:135:0)
[13:34:50.273] Timer tick, asking Buildbucket for the build status
[13:34:50.414] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:50.414] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:136:0) after 1m0s
[13:35:50.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:136:0)
[13:35:50.451] Timer tick, asking Buildbucket for the build status
[13:35:50.512] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:50.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:137:0) after 1m0s
[13:36:50.570] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:137:0)
[13:36:50.570] Timer tick, asking Buildbucket for the build status
[13:36:50.813] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:50.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:138:0) after 1m0s
[13:37:50.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:138:0)
[13:37:50.884] Timer tick, asking Buildbucket for the build status
[13:37:50.956] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:50.956] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:139:0) after 1m0s
[13:38:51.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:139:0)
[13:38:51.079] Timer tick, asking Buildbucket for the build status
[13:38:51.145] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:51.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:140:0) after 1m0s
[13:39:51.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:140:0)
[13:39:51.194] Timer tick, asking Buildbucket for the build status
[13:39:51.263] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:51.263] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:141:0) after 1m0s
[13:40:51.275] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:141:0)
[13:40:51.275] Timer tick, asking Buildbucket for the build status
[13:40:51.561] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:51.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:142:0) after 1m0s
[13:41:51.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:142:0)
[13:41:51.555] Timer tick, asking Buildbucket for the build status
[13:41:51.688] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:51.688] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:143:0) after 1m0s
[13:42:51.711] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:143:0)
[13:42:51.711] Timer tick, asking Buildbucket for the build status
[13:42:51.773] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:51.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:144:0) after 1m0s
[13:43:51.797] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:144:0)
[13:43:51.797] Timer tick, asking Buildbucket for the build status
[13:43:51.863] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:51.863] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:145:0) after 1m0s
[13:44:51.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:145:0)
[13:44:51.876] Timer tick, asking Buildbucket for the build status
[13:44:52.088] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:52.088] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:146:0) after 1m0s
[13:45:52.147] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:146:0)
[13:45:52.147] Timer tick, asking Buildbucket for the build status
[13:45:52.207] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:52.208] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:147:0) after 1m0s
[13:46:52.242] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:147:0)
[13:46:52.242] Timer tick, asking Buildbucket for the build status
[13:46:52.387] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:52.387] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:148:0) after 1m0s
[13:47:52.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:148:0)
[13:47:52.411] Timer tick, asking Buildbucket for the build status
[13:47:52.632] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:52.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:149:0) after 1m0s
[13:48:52.652] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:149:0)
[13:48:52.652] Timer tick, asking Buildbucket for the build status
[13:48:52.774] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:52.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:150:0) after 1m0s
[13:49:52.802] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:150:0)
[13:49:52.802] Timer tick, asking Buildbucket for the build status
[13:49:52.967] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:52.967] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:151:0) after 1m0s
[13:50:53.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:151:0)
[13:50:53.057] Timer tick, asking Buildbucket for the build status
[13:50:53.127] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:53.127] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:152:0) after 1m0s
[13:51:53.202] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:152:0)
[13:51:53.202] Timer tick, asking Buildbucket for the build status
[13:51:53.628] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:53.628] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:153:0) after 1m0s
[13:52:53.673] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:153:0)
[13:52:53.673] Timer tick, asking Buildbucket for the build status
[13:52:53.746] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:53.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:154:0) after 1m0s
[13:53:53.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:154:0)
[13:53:53.782] Timer tick, asking Buildbucket for the build status
[13:53:53.851] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:53.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:155:0) after 1m0s
[13:54:53.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:155:0)
[13:54:53.883] Timer tick, asking Buildbucket for the build status
[13:54:54.011] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:54.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:156:0) after 1m0s
[13:55:54.040] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:156:0)
[13:55:54.040] Timer tick, asking Buildbucket for the build status
[13:55:54.129] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:54.129] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:157:0) after 1m0s
[13:56:54.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:157:0)
[13:56:54.134] Timer tick, asking Buildbucket for the build status
[13:56:54.281] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:54.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:158:0) after 1m0s
[13:57:54.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:158:0)
[13:57:54.297] Timer tick, asking Buildbucket for the build status
[13:57:54.367] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:54.367] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:159:0) after 1m0s
[13:58:54.440] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:159:0)
[13:58:54.440] Timer tick, asking Buildbucket for the build status
[13:58:54.522] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:54.522] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:160:0) after 1m0s
[13:59:54.531] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:160:0)
[13:59:54.531] Timer tick, asking Buildbucket for the build status
[13:59:54.601] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:54.601] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:161:0) after 1m0s
[14:00:54.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:161:0)
[14:00:54.674] Timer tick, asking Buildbucket for the build status
[14:00:54.764] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:54.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:162:0) after 1m0s
[14:01:54.779] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:162:0)
[14:01:54.779] Timer tick, asking Buildbucket for the build status
[14:01:54.912] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:54.912] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:163:0) after 1m0s
[14:02:55.005] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:163:0)
[14:02:55.005] Timer tick, asking Buildbucket for the build status
[14:02:55.113] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:55.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:164:0) after 1m0s
[14:03:55.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:164:0)
[14:03:55.186] Timer tick, asking Buildbucket for the build status
[14:03:55.291] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:55.291] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:165:0) after 1m0s
[14:04:55.337] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:165:0)
[14:04:55.337] Timer tick, asking Buildbucket for the build status
[14:04:55.437] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:55.437] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:166:0) after 1m0s
[14:05:55.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:166:0)
[14:05:55.476] Timer tick, asking Buildbucket for the build status
[14:05:55.544] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:55.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:167:0) after 1m0s
[14:06:55.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:167:0)
[14:06:55.579] Timer tick, asking Buildbucket for the build status
[14:06:55.759] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:55.759] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:168:0) after 1m0s
[14:07:55.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:168:0)
[14:07:55.821] Timer tick, asking Buildbucket for the build status
[14:07:55.888] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:55.888] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:169:0) after 1m0s
[14:08:55.916] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:169:0)
[14:08:55.916] Timer tick, asking Buildbucket for the build status
[14:08:55.970] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:55.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:170:0) after 1m0s
[14:09:56.059] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:170:0)
[14:09:56.059] Timer tick, asking Buildbucket for the build status
[14:09:56.349] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:56.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:171:0) after 1m0s
[14:10:56.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:171:0)
[14:10:56.369] Timer tick, asking Buildbucket for the build status
[14:10:56.484] Build 8866920710721057984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:56.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9032350772764021984:172:0) after 1m0s
[14:11:06.888] Received PubSub notification, asking Buildbucket for the build status
[14:11:07.166] Build 8866920710721057984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:11:07.166] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1602252666134249",
"created_by": "project:infra",
"created_ts": "1602242474782176",
"id": "8866920710721057984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4287.0\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"3788c733-6f47-416e-b9b2-fa8ed8742077\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4287.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-2yu8\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"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": "1602242492122598",
"status": "COMPLETED",
"status_changed_ts": "1602252666586857",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9032350772764021984",
"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/8866920710721057984/+/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:4f25e97caa8d4210",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1602252666627301",
"url": "https://ci.chromium.org/b/8866920710721057984",
"utcnow_ts": "1602252667134886"
}
}
[14:11:07.166] Invocation finished in 2h49m53.71653016s with status SUCCEEDED