[13:45:06.498] New invocation is queued and will start shortly
[13:45:06.499] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[13:45:10.577] Starting the invocation (attempt 1)
[13:45:10.618] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:45:10.618] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:45:10.618] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9030167393184738992",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"88.0.4313.2\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"b11626af-7ccc-41fa-ae6e-1495818afa23\",\"title\":\"publish_tarball/0\"}]},\"version\":\"88.0.4313.2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9030167393184738992",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[13:45:11.191] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1604324710708498",
"id": "8864737328103325632",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4313.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b11626af-7ccc-41fa-ae6e-1495818afa23\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4313.2\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604324710881245",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9030167393184738992",
"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/8864737328103325632/+/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": "1604324710881360",
"url": "https://ci.chromium.org/b/8864737328103325632",
"utcnow_ts": "1604324711179914"
}
}
[13:45:11.191] Task URL: https://ci.chromium.org/b/8864737328103325632
[13:45:11.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:2:0) after 1m0s
[13:45:32.620] Received PubSub notification, asking Buildbucket for the build status
[13:45:32.698] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:11.208] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:2:0)
[13:46:11.208] Timer tick, asking Buildbucket for the build status
[13:46:11.495] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:11.495] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:4:0) after 1m0s
[13:47:11.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:4:0)
[13:47:11.548] Timer tick, asking Buildbucket for the build status
[13:47:11.627] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:11.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:5:0) after 1m0s
[13:48:11.680] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:5:0)
[13:48:11.680] Timer tick, asking Buildbucket for the build status
[13:48:11.960] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:11.960] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:6:0) after 1m0s
[13:49:11.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:6:0)
[13:49:11.981] Timer tick, asking Buildbucket for the build status
[13:49:12.202] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:12.202] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:7:0) after 1m0s
[13:50:12.224] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:7:0)
[13:50:12.224] Timer tick, asking Buildbucket for the build status
[13:50:12.339] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:12.339] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:8:0) after 1m0s
[13:51:12.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:8:0)
[13:51:12.358] Timer tick, asking Buildbucket for the build status
[13:51:12.490] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:12.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:9:0) after 1m0s
[13:52:12.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:9:0)
[13:52:12.529] Timer tick, asking Buildbucket for the build status
[13:52:12.620] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:12.621] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:10:0) after 1m0s
[13:53:12.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:10:0)
[13:53:12.648] Timer tick, asking Buildbucket for the build status
[13:53:12.731] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:12.731] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:11:0) after 1m0s
[13:54:12.815] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:11:0)
[13:54:12.815] Timer tick, asking Buildbucket for the build status
[13:54:12.878] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:12.878] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:12:0) after 1m0s
[13:55:12.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:12:0)
[13:55:12.907] Timer tick, asking Buildbucket for the build status
[13:55:12.982] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:12.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:13:0) after 1m0s
[13:56:13.002] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:13:0)
[13:56:13.003] Timer tick, asking Buildbucket for the build status
[13:56:13.131] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:13.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:14:0) after 1m0s
[13:57:13.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:14:0)
[13:57:13.186] Timer tick, asking Buildbucket for the build status
[13:57:13.828] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:13.828] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:15:0) after 1m0s
[13:58:13.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:15:0)
[13:58:13.879] Timer tick, asking Buildbucket for the build status
[13:58:14.680] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:14.680] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:16:0) after 1m0s
[13:59:14.737] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:16:0)
[13:59:14.737] Timer tick, asking Buildbucket for the build status
[13:59:14.812] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:14.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:17:0) after 1m0s
[14:00:14.920] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:17:0)
[14:00:14.920] Timer tick, asking Buildbucket for the build status
[14:00:15.011] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:15.011] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:18:0) after 1m0s
[14:01:15.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:18:0)
[14:01:15.041] Timer tick, asking Buildbucket for the build status
[14:01:15.207] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:15.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:19:0) after 1m0s
[14:02:15.248] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:19:0)
[14:02:15.248] Timer tick, asking Buildbucket for the build status
[14:02:15.326] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:15.326] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:20:0) after 1m0s
[14:03:15.374] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:20:0)
[14:03:15.374] Timer tick, asking Buildbucket for the build status
[14:03:15.574] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:15.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:21:0) after 1m0s
[14:04:15.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:21:0)
[14:04:15.564] Timer tick, asking Buildbucket for the build status
[14:04:15.639] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:15.639] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:22:0) after 1m0s
[14:05:15.671] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:22:0)
[14:05:15.671] Timer tick, asking Buildbucket for the build status
[14:05:15.804] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:15.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:23:0) after 1m0s
[14:06:15.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:23:0)
[14:06:15.832] Timer tick, asking Buildbucket for the build status
[14:06:15.957] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:15.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:24:0) after 1m0s
[14:07:15.991] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:24:0)
[14:07:15.991] Timer tick, asking Buildbucket for the build status
[14:07:16.074] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:16.074] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:25:0) after 1m0s
[14:08:16.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:25:0)
[14:08:16.126] Timer tick, asking Buildbucket for the build status
[14:08:16.253] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:16.253] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:26:0) after 1m0s
[14:09:16.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:26:0)
[14:09:16.308] Timer tick, asking Buildbucket for the build status
[14:09:16.403] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:16.404] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:27:0) after 1m0s
[14:10:16.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:27:0)
[14:10:16.427] Timer tick, asking Buildbucket for the build status
[14:10:16.632] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:16.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:28:0) after 1m0s
[14:11:16.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:28:0)
[14:11:16.645] Timer tick, asking Buildbucket for the build status
[14:11:16.765] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:16.765] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:29:0) after 1m0s
[14:12:16.806] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:29:0)
[14:12:16.806] Timer tick, asking Buildbucket for the build status
[14:12:16.984] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:16.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:30:0) after 1m0s
[14:13:17.062] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:30:0)
[14:13:17.062] Timer tick, asking Buildbucket for the build status
[14:13:17.111] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:17.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:31:0) after 1m0s
[14:14:17.206] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:31:0)
[14:14:17.206] Timer tick, asking Buildbucket for the build status
[14:14:17.266] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:17.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:32:0) after 1m0s
[14:15:17.298] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:32:0)
[14:15:17.298] Timer tick, asking Buildbucket for the build status
[14:15:17.626] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:17.626] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:33:0) after 1m0s
[14:16:17.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:33:0)
[14:16:17.653] Timer tick, asking Buildbucket for the build status
[14:16:17.773] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:17.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:34:0) after 1m0s
[14:17:17.811] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:34:0)
[14:17:17.811] Timer tick, asking Buildbucket for the build status
[14:17:17.866] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:17.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:35:0) after 1m0s
[14:18:18.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:35:0)
[14:18:18.279] Timer tick, asking Buildbucket for the build status
[14:18:18.344] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:18.344] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:36:0) after 1m0s
[14:19:18.627] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:36:0)
[14:19:18.627] Timer tick, asking Buildbucket for the build status
[14:19:18.697] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:18.697] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:37:0) after 1m0s
[14:20:18.951] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:37:0)
[14:20:18.951] Timer tick, asking Buildbucket for the build status
[14:20:19.072] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:19.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:38:0) after 1m0s
[14:21:19.229] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:38:0)
[14:21:19.229] Timer tick, asking Buildbucket for the build status
[14:21:19.306] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:19.306] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:39:0) after 1m0s
[14:22:19.310] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:39:0)
[14:22:19.310] Timer tick, asking Buildbucket for the build status
[14:22:19.529] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:19.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:40:0) after 1m0s
[14:23:19.557] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:40:0)
[14:23:19.557] Timer tick, asking Buildbucket for the build status
[14:23:19.617] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:19.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:41:0) after 1m0s
[14:24:19.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:41:0)
[14:24:19.716] Timer tick, asking Buildbucket for the build status
[14:24:19.778] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:19.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:42:0) after 1m0s
[14:25:19.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:42:0)
[14:25:19.833] Timer tick, asking Buildbucket for the build status
[14:25:19.958] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:19.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:43:0) after 1m0s
[14:26:19.990] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:43:0)
[14:26:19.990] Timer tick, asking Buildbucket for the build status
[14:26:20.057] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:20.057] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:44:0) after 1m0s
[14:27:20.135] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:44:0)
[14:27:20.135] Timer tick, asking Buildbucket for the build status
[14:27:20.369] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:20.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:45:0) after 1m0s
[14:28:20.415] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:45:0)
[14:28:20.415] Timer tick, asking Buildbucket for the build status
[14:28:20.607] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:20.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:46:0) after 1m0s
[14:29:20.638] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:46:0)
[14:29:20.638] Timer tick, asking Buildbucket for the build status
[14:29:20.714] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:20.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:47:0) after 1m0s
[14:30:20.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:47:0)
[14:30:20.767] Timer tick, asking Buildbucket for the build status
[14:30:21.225] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:21.225] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:48:0) after 1m0s
[14:31:21.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:48:0)
[14:31:21.349] Timer tick, asking Buildbucket for the build status
[14:31:21.624] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:21.624] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:49:0) after 1m0s
[14:32:21.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:49:0)
[14:32:21.693] Timer tick, asking Buildbucket for the build status
[14:32:21.802] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:21.802] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:50:0) after 1m0s
[14:33:21.902] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:50:0)
[14:33:21.902] Timer tick, asking Buildbucket for the build status
[14:33:21.976] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:21.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:51:0) after 1m0s
[14:34:22.046] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:51:0)
[14:34:22.046] Timer tick, asking Buildbucket for the build status
[14:34:22.140] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:22.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:52:0) after 1m0s
[14:35:22.193] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:52:0)
[14:35:22.193] Timer tick, asking Buildbucket for the build status
[14:35:22.310] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:22.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:53:0) after 1m0s
[14:36:22.330] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:53:0)
[14:36:22.330] Timer tick, asking Buildbucket for the build status
[14:36:22.477] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:22.477] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:54:0) after 1m0s
[14:37:22.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:54:0)
[14:37:22.506] Timer tick, asking Buildbucket for the build status
[14:37:22.586] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:22.587] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:55:0) after 1m0s
[14:38:22.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:55:0)
[14:38:22.597] Timer tick, asking Buildbucket for the build status
[14:38:22.726] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:22.726] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:56:0) after 1m0s
[14:39:22.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:56:0)
[14:39:22.751] Timer tick, asking Buildbucket for the build status
[14:39:22.813] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:22.813] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:57:0) after 1m0s
[14:40:22.843] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:57:0)
[14:40:22.843] Timer tick, asking Buildbucket for the build status
[14:40:23.145] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:23.145] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:58:0) after 1m0s
[14:41:23.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:58:0)
[14:41:23.149] Timer tick, asking Buildbucket for the build status
[14:41:23.319] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:23.319] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:59:0) after 1m0s
[14:42:23.375] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:59:0)
[14:42:23.375] Timer tick, asking Buildbucket for the build status
[14:42:23.591] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:23.591] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:60:0) after 1m0s
[14:43:23.593] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:60:0)
[14:43:23.593] Timer tick, asking Buildbucket for the build status
[14:43:23.658] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:23.658] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:61:0) after 1m0s
[14:44:23.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:61:0)
[14:44:23.777] Timer tick, asking Buildbucket for the build status
[14:44:23.853] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:23.853] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:62:0) after 1m0s
[14:45:23.874] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:62:0)
[14:45:23.874] Timer tick, asking Buildbucket for the build status
[14:45:23.977] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:23.977] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:63:0) after 1m0s
[14:46:24.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:63:0)
[14:46:24.015] Timer tick, asking Buildbucket for the build status
[14:46:24.126] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:24.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:64:0) after 1m0s
[14:47:24.171] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:64:0)
[14:47:24.171] Timer tick, asking Buildbucket for the build status
[14:47:24.233] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:24.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:65:0) after 1m0s
[14:48:24.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:65:0)
[14:48:24.297] Timer tick, asking Buildbucket for the build status
[14:48:24.366] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:24.366] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:66:0) after 1m0s
[14:49:24.425] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:66:0)
[14:49:24.425] Timer tick, asking Buildbucket for the build status
[14:49:24.497] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:24.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:67:0) after 1m0s
[14:50:24.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:67:0)
[14:50:24.508] Timer tick, asking Buildbucket for the build status
[14:50:24.622] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:24.622] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:68:0) after 1m0s
[14:51:24.674] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:68:0)
[14:51:24.674] Timer tick, asking Buildbucket for the build status
[14:51:24.742] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:24.742] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:69:0) after 1m0s
[14:52:24.836] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:69:0)
[14:52:24.836] Timer tick, asking Buildbucket for the build status
[14:52:24.919] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:24.919] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:70:0) after 1m0s
[14:53:25.020] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:70:0)
[14:53:25.020] Timer tick, asking Buildbucket for the build status
[14:53:25.087] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:25.087] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:71:0) after 1m0s
[14:54:25.506] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:71:0)
[14:54:25.506] Timer tick, asking Buildbucket for the build status
[14:54:25.574] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:25.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:72:0) after 1m0s
[14:55:25.940] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:72:0)
[14:55:25.940] Timer tick, asking Buildbucket for the build status
[14:55:26.064] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:26.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:73:0) after 1m0s
[14:56:26.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:73:0)
[14:56:26.236] Timer tick, asking Buildbucket for the build status
[14:56:26.671] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:26.671] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:74:0) after 1m0s
[14:57:26.808] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:74:0)
[14:57:26.808] Timer tick, asking Buildbucket for the build status
[14:57:26.881] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:26.881] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:75:0) after 1m0s
[14:58:27.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:75:0)
[14:58:27.635] Timer tick, asking Buildbucket for the build status
[14:58:27.727] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:27.727] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:76:0) after 1m0s
[14:59:27.830] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:76:0)
[14:59:27.830] Timer tick, asking Buildbucket for the build status
[14:59:28.158] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:28.158] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:77:0) after 1m0s
[15:00:28.318] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:77:0)
[15:00:28.318] Timer tick, asking Buildbucket for the build status
[15:00:28.851] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:28.851] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:78:0) after 1m0s
[15:01:28.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:78:0)
[15:01:28.957] Timer tick, asking Buildbucket for the build status
[15:01:29.071] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:29.071] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:79:0) after 1m0s
[15:02:29.105] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:79:0)
[15:02:29.105] Timer tick, asking Buildbucket for the build status
[15:02:29.192] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:29.192] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:80:0) after 1m0s
[15:03:29.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:80:0)
[15:03:29.199] Timer tick, asking Buildbucket for the build status
[15:03:29.273] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:29.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:81:0) after 1m0s
[15:04:29.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:81:0)
[15:04:29.312] Timer tick, asking Buildbucket for the build status
[15:04:29.432] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:29.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:82:0) after 1m0s
[15:05:29.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:82:0)
[15:05:29.499] Timer tick, asking Buildbucket for the build status
[15:05:29.612] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:29.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:83:0) after 1m0s
[15:06:29.693] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:83:0)
[15:06:29.693] Timer tick, asking Buildbucket for the build status
[15:06:29.925] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:29.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:84:0) after 1m0s
[15:07:29.952] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:84:0)
[15:07:29.952] Timer tick, asking Buildbucket for the build status
[15:07:30.391] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:30.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:85:0) after 1m0s
[15:08:30.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:85:0)
[15:08:30.493] Timer tick, asking Buildbucket for the build status
[15:08:30.598] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:30.598] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:86:0) after 1m0s
[15:09:30.588] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:86:0)
[15:09:30.588] Timer tick, asking Buildbucket for the build status
[15:09:30.646] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:30.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:87:0) after 1m0s
[15:10:30.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:87:0)
[15:10:30.801] Timer tick, asking Buildbucket for the build status
[15:10:30.951] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:30.951] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:88:0) after 1m0s
[15:11:31.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:88:0)
[15:11:31.047] Timer tick, asking Buildbucket for the build status
[15:11:31.136] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:31.136] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:89:0) after 1m0s
[15:12:31.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:89:0)
[15:12:31.282] Timer tick, asking Buildbucket for the build status
[15:12:31.479] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:31.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:90:0) after 1m0s
[15:13:31.615] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:90:0)
[15:13:31.615] Timer tick, asking Buildbucket for the build status
[15:13:31.685] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:31.685] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:91:0) after 1m0s
[15:14:31.754] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:91:0)
[15:14:31.754] Timer tick, asking Buildbucket for the build status
[15:14:31.930] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:31.930] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:92:0) after 1m0s
[15:15:32.024] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:92:0)
[15:15:32.024] Timer tick, asking Buildbucket for the build status
[15:15:32.141] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:32.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:93:0) after 1m0s
[15:16:32.479] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:93:0)
[15:16:32.479] Timer tick, asking Buildbucket for the build status
[15:16:32.660] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:32.660] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:94:0) after 1m0s
[15:17:32.899] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:94:0)
[15:17:32.899] Timer tick, asking Buildbucket for the build status
[15:17:33.033] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:33.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:95:0) after 1m0s
[15:18:33.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:95:0)
[15:18:33.192] Timer tick, asking Buildbucket for the build status
[15:18:33.277] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:33.277] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:96:0) after 1m0s
[15:19:33.382] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:96:0)
[15:19:33.382] Timer tick, asking Buildbucket for the build status
[15:19:33.884] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:33.884] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:97:0) after 1m0s
[15:20:33.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:97:0)
[15:20:33.932] Timer tick, asking Buildbucket for the build status
[15:20:34.131] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:34.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:98:0) after 1m0s
[15:21:34.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:98:0)
[15:21:34.248] Timer tick, asking Buildbucket for the build status
[15:21:34.375] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:34.375] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:99:0) after 1m0s
[15:22:34.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:99:0)
[15:22:34.453] Timer tick, asking Buildbucket for the build status
[15:22:36.103] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:36.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:100:0) after 1m0s
[15:23:36.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:100:0)
[15:23:36.159] Timer tick, asking Buildbucket for the build status
[15:23:36.222] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:36.222] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:101:0) after 1m0s
[15:24:36.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:101:0)
[15:24:36.249] Timer tick, asking Buildbucket for the build status
[15:24:36.311] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:36.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:102:0) after 1m0s
[15:25:36.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:102:0)
[15:25:36.383] Timer tick, asking Buildbucket for the build status
[15:25:36.679] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:36.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:103:0) after 1m0s
[15:26:36.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:103:0)
[15:26:36.776] Timer tick, asking Buildbucket for the build status
[15:26:36.841] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:36.842] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:104:0) after 1m0s
[15:27:36.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:104:0)
[15:27:36.879] Timer tick, asking Buildbucket for the build status
[15:27:36.939] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:36.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:105:0) after 1m0s
[15:28:36.956] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:105:0)
[15:28:36.956] Timer tick, asking Buildbucket for the build status
[15:28:37.050] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:37.050] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:106:0) after 1m0s
[15:29:37.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:106:0)
[15:29:37.084] Timer tick, asking Buildbucket for the build status
[15:29:37.143] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:37.143] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:107:0) after 1m0s
[15:30:37.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:107:0)
[15:30:37.214] Timer tick, asking Buildbucket for the build status
[15:30:37.329] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:37.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:108:0) after 1m0s
[15:31:37.388] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:108:0)
[15:31:37.388] Timer tick, asking Buildbucket for the build status
[15:31:37.453] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:37.453] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:109:0) after 1m0s
[15:32:37.514] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:109:0)
[15:32:37.514] Timer tick, asking Buildbucket for the build status
[15:32:37.580] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:37.580] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:110:0) after 1m0s
[15:33:37.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:110:0)
[15:33:37.702] Timer tick, asking Buildbucket for the build status
[15:33:37.805] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:37.805] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:111:0) after 1m0s
[15:34:37.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:111:0)
[15:34:37.838] Timer tick, asking Buildbucket for the build status
[15:34:37.905] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:37.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:112:0) after 1m0s
[15:35:38.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:112:0)
[15:35:38.198] Timer tick, asking Buildbucket for the build status
[15:35:38.288] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:38.288] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:113:0) after 1m0s
[15:36:38.469] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:113:0)
[15:36:38.469] Timer tick, asking Buildbucket for the build status
[15:36:38.623] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:38.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:114:0) after 1m0s
[15:37:38.679] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:114:0)
[15:37:38.679] Timer tick, asking Buildbucket for the build status
[15:37:38.761] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:38.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:115:0) after 1m0s
[15:38:38.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:115:0)
[15:38:38.859] Timer tick, asking Buildbucket for the build status
[15:38:38.928] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:38.928] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:116:0) after 1m0s
[15:39:38.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:116:0)
[15:39:38.947] Timer tick, asking Buildbucket for the build status
[15:39:39.234] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:39.234] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:117:0) after 1m0s
[15:40:39.342] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:117:0)
[15:40:39.342] Timer tick, asking Buildbucket for the build status
[15:40:39.457] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:39.457] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:118:0) after 1m0s
[15:41:39.532] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:118:0)
[15:41:39.532] Timer tick, asking Buildbucket for the build status
[15:41:39.613] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:39.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:119:0) after 1m0s
[15:42:39.618] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:119:0)
[15:42:39.618] Timer tick, asking Buildbucket for the build status
[15:42:39.859] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:39.859] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:120:0) after 1m0s
[15:43:39.855] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:120:0)
[15:43:39.855] Timer tick, asking Buildbucket for the build status
[15:43:39.925] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:39.925] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:121:0) after 1m0s
[15:44:40.110] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:121:0)
[15:44:40.110] Timer tick, asking Buildbucket for the build status
[15:44:40.199] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:40.199] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:122:0) after 1m0s
[15:45:40.655] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:122:0)
[15:45:40.655] Timer tick, asking Buildbucket for the build status
[15:45:40.809] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:40.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:123:0) after 1m0s
[15:46:41.467] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:123:0)
[15:46:41.467] Timer tick, asking Buildbucket for the build status
[15:46:41.644] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:41.644] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:124:0) after 1m0s
[15:47:41.796] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:124:0)
[15:47:41.796] Timer tick, asking Buildbucket for the build status
[15:47:41.894] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:41.894] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:125:0) after 1m0s
[15:48:41.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:125:0)
[15:48:41.932] Timer tick, asking Buildbucket for the build status
[15:48:42.112] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:42.112] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:126:0) after 1m0s
[15:49:42.155] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:126:0)
[15:49:42.155] Timer tick, asking Buildbucket for the build status
[15:49:42.265] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:42.265] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:127:0) after 1m0s
[15:50:42.485] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:127:0)
[15:50:42.485] Timer tick, asking Buildbucket for the build status
[15:50:42.604] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:42.604] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:128:0) after 1m0s
[15:51:42.784] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:128:0)
[15:51:42.784] Timer tick, asking Buildbucket for the build status
[15:51:42.846] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:42.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:129:0) after 1m0s
[15:52:42.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:129:0)
[15:52:42.878] Timer tick, asking Buildbucket for the build status
[15:52:43.407] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:43.407] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:130:0) after 1m0s
[15:53:43.597] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:130:0)
[15:53:43.597] Timer tick, asking Buildbucket for the build status
[15:53:43.672] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:43.672] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:131:0) after 1m0s
[15:54:43.731] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:131:0)
[15:54:43.731] Timer tick, asking Buildbucket for the build status
[15:54:43.816] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:43.816] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:132:0) after 1m0s
[15:55:43.826] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:132:0)
[15:55:43.826] Timer tick, asking Buildbucket for the build status
[15:55:43.927] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:43.927] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:133:0) after 1m0s
[15:56:43.949] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:133:0)
[15:56:43.949] Timer tick, asking Buildbucket for the build status
[15:56:44.013] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:44.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:134:0) after 1m0s
[15:57:44.101] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:134:0)
[15:57:44.101] Timer tick, asking Buildbucket for the build status
[15:57:44.226] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:44.226] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:135:0) after 1m0s
[15:58:44.268] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:135:0)
[15:58:44.268] Timer tick, asking Buildbucket for the build status
[15:58:44.359] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:44.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:136:0) after 1m0s
[15:59:44.436] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:136:0)
[15:59:44.436] Timer tick, asking Buildbucket for the build status
[15:59:44.537] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:44.537] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:137:0) after 1m0s
[16:00:44.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:137:0)
[16:00:44.620] Timer tick, asking Buildbucket for the build status
[16:00:44.774] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:44.774] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:138:0) after 1m0s
[16:01:44.852] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:138:0)
[16:01:44.852] Timer tick, asking Buildbucket for the build status
[16:01:44.923] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:44.923] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:139:0) after 1m0s
[16:02:44.979] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:139:0)
[16:02:44.979] Timer tick, asking Buildbucket for the build status
[16:02:45.118] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:45.118] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:140:0) after 1m0s
[16:03:45.353] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:140:0)
[16:03:45.353] Timer tick, asking Buildbucket for the build status
[16:03:45.428] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:45.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:141:0) after 1m0s
[16:04:45.517] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:141:0)
[16:04:45.517] Timer tick, asking Buildbucket for the build status
[16:04:45.592] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:45.592] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:142:0) after 1m0s
[16:05:45.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:142:0)
[16:05:45.625] Timer tick, asking Buildbucket for the build status
[16:05:45.741] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:45.741] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:143:0) after 1m0s
[16:06:46.001] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:143:0)
[16:06:46.001] Timer tick, asking Buildbucket for the build status
[16:06:46.095] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:46.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:144:0) after 1m0s
[16:07:46.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:144:0)
[16:07:46.156] Timer tick, asking Buildbucket for the build status
[16:07:46.325] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:46.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:145:0) after 1m0s
[16:08:46.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:145:0)
[16:08:46.356] Timer tick, asking Buildbucket for the build status
[16:08:46.426] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:46.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:146:0) after 1m0s
[16:09:46.488] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:146:0)
[16:09:46.488] Timer tick, asking Buildbucket for the build status
[16:09:46.573] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:46.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:147:0) after 1m0s
[16:10:46.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:147:0)
[16:10:46.647] Timer tick, asking Buildbucket for the build status
[16:10:47.244] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:47.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:148:0) after 1m0s
[16:11:47.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:148:0)
[16:11:47.376] Timer tick, asking Buildbucket for the build status
[16:11:47.496] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:47.496] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:149:0) after 1m0s
[16:12:47.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:149:0)
[16:12:47.776] Timer tick, asking Buildbucket for the build status
[16:12:48.661] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:48.661] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:150:0) after 1m0s
[16:13:48.873] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:150:0)
[16:13:48.873] Timer tick, asking Buildbucket for the build status
[16:13:48.971] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:48.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:151:0) after 1m0s
[16:14:49.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:151:0)
[16:14:49.064] Timer tick, asking Buildbucket for the build status
[16:14:49.141] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:49.141] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:152:0) after 1m0s
[16:15:49.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:152:0)
[16:15:49.274] Timer tick, asking Buildbucket for the build status
[16:15:49.872] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:49.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:153:0) after 1m0s
[16:16:50.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:153:0)
[16:16:50.127] Timer tick, asking Buildbucket for the build status
[16:16:50.207] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:50.207] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:154:0) after 1m0s
[16:17:50.335] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:154:0)
[16:17:50.335] Timer tick, asking Buildbucket for the build status
[16:17:50.421] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:50.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:155:0) after 1m0s
[16:18:50.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:155:0)
[16:18:50.465] Timer tick, asking Buildbucket for the build status
[16:18:50.543] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:50.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:156:0) after 1m0s
[16:19:50.607] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:156:0)
[16:19:50.607] Timer tick, asking Buildbucket for the build status
[16:19:50.724] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:50.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:157:0) after 1m0s
[16:20:50.818] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:157:0)
[16:20:50.818] Timer tick, asking Buildbucket for the build status
[16:20:50.972] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:50.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:158:0) after 1m0s
[16:21:51.109] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:158:0)
[16:21:51.109] Timer tick, asking Buildbucket for the build status
[16:21:51.432] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:51.433] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:159:0) after 1m0s
[16:22:51.476] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:159:0)
[16:22:51.476] Timer tick, asking Buildbucket for the build status
[16:22:51.541] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:51.541] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:160:0) after 1m0s
[16:23:51.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:160:0)
[16:23:51.697] Timer tick, asking Buildbucket for the build status
[16:23:51.819] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:51.819] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:161:0) after 1m0s
[16:24:51.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:161:0)
[16:24:51.853] Timer tick, asking Buildbucket for the build status
[16:24:52.030] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:52.030] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:162:0) after 1m0s
[16:25:52.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:162:0)
[16:25:52.239] Timer tick, asking Buildbucket for the build status
[16:25:52.412] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:52.412] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:163:0) after 1m0s
[16:26:52.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:163:0)
[16:26:52.577] Timer tick, asking Buildbucket for the build status
[16:26:52.649] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:52.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:164:0) after 1m0s
[16:27:52.651] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:164:0)
[16:27:52.651] Timer tick, asking Buildbucket for the build status
[16:27:53.245] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:53.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:165:0) after 1m0s
[16:28:53.495] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:165:0)
[16:28:53.495] Timer tick, asking Buildbucket for the build status
[16:28:53.578] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:53.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:166:0) after 1m0s
[16:29:53.609] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:166:0)
[16:29:53.609] Timer tick, asking Buildbucket for the build status
[16:29:53.677] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:53.677] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:167:0) after 1m0s
[16:30:53.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:167:0)
[16:30:53.735] Timer tick, asking Buildbucket for the build status
[16:30:54.079] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:54.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:168:0) after 1m0s
[16:31:54.073] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:168:0)
[16:31:54.073] Timer tick, asking Buildbucket for the build status
[16:31:54.132] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:54.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:169:0) after 1m0s
[16:32:54.162] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:169:0)
[16:32:54.162] Timer tick, asking Buildbucket for the build status
[16:32:54.325] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:54.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:170:0) after 1m0s
[16:33:54.345] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:170:0)
[16:33:54.345] Timer tick, asking Buildbucket for the build status
[16:33:54.646] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:54.646] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:171:0) after 1m0s
[16:34:54.735] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:171:0)
[16:34:54.735] Timer tick, asking Buildbucket for the build status
[16:34:54.797] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:54.797] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:172:0) after 1m0s
[16:35:54.833] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:172:0)
[16:35:54.833] Timer tick, asking Buildbucket for the build status
[16:35:55.004] Build 8864737328103325632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:55.004] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9030167393184738992:173:0) after 1m0s
[16:36:46.257] Received PubSub notification, asking Buildbucket for the build status
[16:36:46.332] Build 8864737328103325632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[16:36:46.332] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1604335005268295",
"created_by": "project:infra",
"created_ts": "1604324710708498",
"id": "8864737328103325632",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"88.0.4313.2\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"b11626af-7ccc-41fa-ae6e-1495818afa23\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"88.0.4313.2\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a26b12d8a59ca9041fe7666278599d55714efad5956e4752511581aec53352b0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-1n23\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604324730994072",
"status": "COMPLETED",
"status_changed_ts": "1604335005706388",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9030167393184738992",
"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/8864737328103325632/+/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:4fa205e6b9f70110",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1604335005789965",
"url": "https://ci.chromium.org/b/8864737328103325632",
"utcnow_ts": "1604335006324962"
}
}
[16:36:46.332] Invocation finished in 2h51m39.85364501s with status SUCCEEDED