[22:46:52.446] New invocation is queued and will start shortly
[22:46:52.446] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[22:46:53.777] Starting the invocation (attempt 1)
[22:46:53.841] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:46:53.841] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:46:53.841] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9040733153291464752",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4183.15\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"6d4553bb-ea66-4d80-b4ae-f6691530dd84\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4183.15\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9040733153291464752",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[22:46:54.318] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1594248413939548",
"id": "8875303091063401984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.15\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6d4553bb-ea66-4d80-b4ae-f6691530dd84\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.15\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594248414139551",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9040733153291464752",
"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/8875303091063401984/+/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": "1594248414139673",
"url": "https://ci.chromium.org/b/8875303091063401984",
"utcnow_ts": "1594248414305906"
}
}
[22:46:54.318] Task URL: https://ci.chromium.org/b/8875303091063401984
[22:46:54.318] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:2:0) after 1m0s
[22:47:24.913] Received PubSub notification, asking Buildbucket for the build status
[22:47:25.181] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:54.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:2:0)
[22:47:54.340] Timer tick, asking Buildbucket for the build status
[22:47:54.516] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:54.516] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:4:0) after 1m0s
[22:48:54.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:4:0)
[22:48:54.551] Timer tick, asking Buildbucket for the build status
[22:48:54.995] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:54.995] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:5:0) after 1m0s
[22:49:55.100] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:5:0)
[22:49:55.100] Timer tick, asking Buildbucket for the build status
[22:49:55.213] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:55.213] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:6:0) after 1m0s
[22:50:55.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:6:0)
[22:50:55.193] Timer tick, asking Buildbucket for the build status
[22:50:55.346] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:55.346] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:7:0) after 1m0s
[22:51:55.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:7:0)
[22:51:55.438] Timer tick, asking Buildbucket for the build status
[22:51:55.557] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:55.557] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:8:0) after 1m0s
[22:52:55.589] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:8:0)
[22:52:55.589] Timer tick, asking Buildbucket for the build status
[22:52:56.003] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:56.003] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:9:0) after 1m0s
[22:53:56.031] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:9:0)
[22:53:56.031] Timer tick, asking Buildbucket for the build status
[22:53:56.242] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:56.242] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:10:0) after 1m0s
[22:54:56.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:10:0)
[22:54:56.287] Timer tick, asking Buildbucket for the build status
[22:54:56.487] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:56.488] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:11:0) after 1m0s
[22:55:56.512] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:11:0)
[22:55:56.512] Timer tick, asking Buildbucket for the build status
[22:55:56.637] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:56.637] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:12:0) after 1m0s
[22:56:56.752] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:12:0)
[22:56:56.752] Timer tick, asking Buildbucket for the build status
[22:56:56.971] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:56.971] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:13:0) after 1m0s
[22:57:57.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:13:0)
[22:57:57.027] Timer tick, asking Buildbucket for the build status
[22:57:57.212] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:57.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:14:0) after 1m0s
[22:58:57.267] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:14:0)
[22:58:57.267] Timer tick, asking Buildbucket for the build status
[22:58:57.363] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:57.363] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:15:0) after 1m0s
[22:59:57.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:15:0)
[22:59:57.396] Timer tick, asking Buildbucket for the build status
[22:59:57.629] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:57.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:16:0) after 1m0s
[23:00:57.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:16:0)
[23:00:57.648] Timer tick, asking Buildbucket for the build status
[23:00:57.979] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:57.979] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:17:0) after 1m0s
[23:01:58.093] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:17:0)
[23:01:58.093] Timer tick, asking Buildbucket for the build status
[23:01:58.907] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:58.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:18:0) after 1m0s
[23:02:58.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:18:0)
[23:02:58.984] Timer tick, asking Buildbucket for the build status
[23:02:59.167] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:59.167] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:19:0) after 1m0s
[23:03:59.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:19:0)
[23:03:59.189] Timer tick, asking Buildbucket for the build status
[23:03:59.252] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:59.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:20:0) after 1m0s
[23:04:59.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:20:0)
[23:04:59.347] Timer tick, asking Buildbucket for the build status
[23:04:59.543] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:59.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:21:0) after 1m0s
[23:05:59.577] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:21:0)
[23:05:59.577] Timer tick, asking Buildbucket for the build status
[23:06:03.981] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:03.981] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:22:0) after 1m0s
[23:07:04.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:22:0)
[23:07:04.029] Timer tick, asking Buildbucket for the build status
[23:07:04.197] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:04.197] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:23:0) after 1m0s
[23:08:04.231] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:23:0)
[23:08:04.231] Timer tick, asking Buildbucket for the build status
[23:08:04.641] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:04.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:24:0) after 1m0s
[23:09:04.697] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:24:0)
[23:09:04.697] Timer tick, asking Buildbucket for the build status
[23:09:04.812] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:04.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:25:0) after 1m0s
[23:10:04.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:25:0)
[23:10:04.832] Timer tick, asking Buildbucket for the build status
[23:10:05.311] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:05.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:26:0) after 1m0s
[23:11:05.390] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:26:0)
[23:11:05.390] Timer tick, asking Buildbucket for the build status
[23:11:05.607] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:05.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:27:0) after 1m0s
[23:12:05.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:27:0)
[23:12:05.632] Timer tick, asking Buildbucket for the build status
[23:12:06.139] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:06.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:28:0) after 1m0s
[23:13:06.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:28:0)
[23:13:06.148] Timer tick, asking Buildbucket for the build status
[23:13:06.432] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:06.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:29:0) after 1m0s
[23:14:06.417] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:29:0)
[23:14:06.417] Timer tick, asking Buildbucket for the build status
[23:14:06.561] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:06.561] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:30:0) after 1m0s
[23:15:06.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:30:0)
[23:15:06.718] Timer tick, asking Buildbucket for the build status
[23:15:06.913] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:06.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:31:0) after 1m0s
[23:16:06.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:31:0)
[23:16:06.977] Timer tick, asking Buildbucket for the build status
[23:16:07.137] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:07.137] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:32:0) after 1m0s
[23:17:07.179] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:32:0)
[23:17:07.179] Timer tick, asking Buildbucket for the build status
[23:17:07.401] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:07.401] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:33:0) after 1m0s
[23:18:07.710] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:33:0)
[23:18:07.710] Timer tick, asking Buildbucket for the build status
[23:18:07.892] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:07.892] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:34:0) after 1m0s
[23:19:08.172] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:34:0)
[23:19:08.172] Timer tick, asking Buildbucket for the build status
[23:19:08.273] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:08.273] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:35:0) after 1m0s
[23:20:08.565] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:35:0)
[23:20:08.565] Timer tick, asking Buildbucket for the build status
[23:20:08.809] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:08.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:36:0) after 1m0s
[23:21:08.987] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:36:0)
[23:21:08.987] Timer tick, asking Buildbucket for the build status
[23:21:09.113] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:09.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:37:0) after 1m0s
[23:22:09.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:37:0)
[23:22:09.312] Timer tick, asking Buildbucket for the build status
[23:22:09.512] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:09.512] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:38:0) after 1m0s
[23:23:09.629] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:38:0)
[23:23:09.629] Timer tick, asking Buildbucket for the build status
[23:23:09.766] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:09.766] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:39:0) after 1m0s
[23:24:09.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:39:0)
[23:24:09.854] Timer tick, asking Buildbucket for the build status
[23:24:12.064] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:12.064] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:40:0) after 1m0s
[23:25:12.168] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:40:0)
[23:25:12.168] Timer tick, asking Buildbucket for the build status
[23:25:12.529] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:12.529] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:41:0) after 1m0s
[23:26:12.590] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:41:0)
[23:26:12.590] Timer tick, asking Buildbucket for the build status
[23:26:12.812] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:12.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:42:0) after 1m0s
[23:27:12.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:42:0)
[23:27:12.853] Timer tick, asking Buildbucket for the build status
[23:27:12.990] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:12.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:43:0) after 1m0s
[23:28:13.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:43:0)
[23:28:13.034] Timer tick, asking Buildbucket for the build status
[23:28:13.268] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:13.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:44:0) after 1m0s
[23:29:13.354] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:44:0)
[23:29:13.354] Timer tick, asking Buildbucket for the build status
[23:29:13.502] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:13.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:45:0) after 1m0s
[23:30:13.914] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:45:0)
[23:30:13.914] Timer tick, asking Buildbucket for the build status
[23:30:14.072] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:14.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:46:0) after 1m0s
[23:31:14.350] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:46:0)
[23:31:14.350] Timer tick, asking Buildbucket for the build status
[23:31:14.600] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:14.600] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:47:0) after 1m0s
[23:32:14.620] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:47:0)
[23:32:14.620] Timer tick, asking Buildbucket for the build status
[23:32:14.793] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:14.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:48:0) after 1m0s
[23:33:14.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:48:0)
[23:33:14.891] Timer tick, asking Buildbucket for the build status
[23:33:15.066] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:15.066] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:49:0) after 1m0s
[23:34:15.086] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:49:0)
[23:34:15.086] Timer tick, asking Buildbucket for the build status
[23:34:15.191] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:15.191] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:50:0) after 1m0s
[23:35:15.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:50:0)
[23:35:15.272] Timer tick, asking Buildbucket for the build status
[23:35:15.773] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:15.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:51:0) after 1m0s
[23:36:15.820] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:51:0)
[23:36:15.820] Timer tick, asking Buildbucket for the build status
[23:36:17.970] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:17.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:52:0) after 1m0s
[23:37:18.236] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:52:0)
[23:37:18.236] Timer tick, asking Buildbucket for the build status
[23:37:18.444] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:18.444] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:53:0) after 1m0s
[23:38:18.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:53:0)
[23:38:18.483] Timer tick, asking Buildbucket for the build status
[23:38:18.611] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:18.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:54:0) after 1m0s
[23:39:18.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:54:0)
[23:39:18.700] Timer tick, asking Buildbucket for the build status
[23:39:18.961] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:18.961] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:55:0) after 1m0s
[23:40:19.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:55:0)
[23:40:19.043] Timer tick, asking Buildbucket for the build status
[23:40:20.212] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:20.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:56:0) after 1m0s
[23:41:20.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:56:0)
[23:41:20.350] Timer tick, asking Buildbucket for the build status
[23:41:20.564] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:20.564] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:57:0) after 1m0s
[23:42:20.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:57:0)
[23:42:20.692] Timer tick, asking Buildbucket for the build status
[23:42:21.798] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:21.798] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:58:0) after 1m0s
[23:43:21.821] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:58:0)
[23:43:21.821] Timer tick, asking Buildbucket for the build status
[23:43:22.065] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:22.065] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:59:0) after 1m0s
[23:44:22.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:59:0)
[23:44:22.125] Timer tick, asking Buildbucket for the build status
[23:44:22.484] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:22.484] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:60:0) after 1m0s
[23:45:22.509] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:60:0)
[23:45:22.509] Timer tick, asking Buildbucket for the build status
[23:45:23.124] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:23.124] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:61:0) after 1m0s
[23:46:23.128] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:61:0)
[23:46:23.128] Timer tick, asking Buildbucket for the build status
[23:46:23.325] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:23.325] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:62:0) after 1m0s
[23:47:23.347] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:62:0)
[23:47:23.347] Timer tick, asking Buildbucket for the build status
[23:47:23.549] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:23.549] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:63:0) after 1m0s
[23:48:23.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:63:0)
[23:48:23.574] Timer tick, asking Buildbucket for the build status
[23:48:23.893] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:23.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:64:0) after 1m0s
[23:49:23.922] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:64:0)
[23:49:23.922] Timer tick, asking Buildbucket for the build status
[23:49:25.212] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:25.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:65:0) after 1m0s
[23:50:25.293] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:65:0)
[23:50:25.293] Timer tick, asking Buildbucket for the build status
[23:50:25.506] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:25.506] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:66:0) after 1m0s
[23:51:25.546] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:66:0)
[23:51:25.546] Timer tick, asking Buildbucket for the build status
[23:51:25.719] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:25.719] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:67:0) after 1m0s
[23:52:25.809] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:67:0)
[23:52:25.809] Timer tick, asking Buildbucket for the build status
[23:52:26.179] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:26.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:68:0) after 1m0s
[23:53:26.218] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:68:0)
[23:53:26.218] Timer tick, asking Buildbucket for the build status
[23:53:26.472] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:26.472] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:69:0) after 1m0s
[23:54:26.541] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:69:0)
[23:54:26.541] Timer tick, asking Buildbucket for the build status
[23:54:26.838] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:26.838] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:70:0) after 1m0s
[23:55:26.903] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:70:0)
[23:55:26.903] Timer tick, asking Buildbucket for the build status
[23:55:27.048] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:27.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:71:0) after 1m0s
[23:56:27.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:71:0)
[23:56:27.084] Timer tick, asking Buildbucket for the build status
[23:56:27.261] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:27.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:72:0) after 1m0s
[23:57:27.864] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:72:0)
[23:57:27.864] Timer tick, asking Buildbucket for the build status
[23:57:28.103] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:28.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:73:0) after 1m0s
[23:58:28.249] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:73:0)
[23:58:28.249] Timer tick, asking Buildbucket for the build status
[23:58:28.394] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:28.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:74:0) after 1m0s
[23:59:28.470] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:74:0)
[23:59:28.470] Timer tick, asking Buildbucket for the build status
[23:59:28.800] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:28.800] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:75:0) after 1m0s
[00:00:29.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:75:0)
[00:00:29.278] Timer tick, asking Buildbucket for the build status
[00:00:29.667] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:29.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:76:0) after 1m0s
[00:01:29.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:76:0)
[00:01:29.879] Timer tick, asking Buildbucket for the build status
[00:01:30.083] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:30.083] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:77:0) after 1m0s
[00:02:30.386] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:77:0)
[00:02:30.386] Timer tick, asking Buildbucket for the build status
[00:02:36.588] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:36.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:78:0) after 1m0s
[00:03:36.666] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:78:0)
[00:03:36.666] Timer tick, asking Buildbucket for the build status
[00:03:36.740] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:36.740] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:79:0) after 1m0s
[00:04:36.738] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:79:0)
[00:04:36.738] Timer tick, asking Buildbucket for the build status
[00:04:36.833] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:36.833] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:80:0) after 1m0s
[00:05:37.047] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:80:0)
[00:05:37.047] Timer tick, asking Buildbucket for the build status
[00:05:37.262] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:37.262] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:81:0) after 1m0s
[00:06:37.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:81:0)
[00:06:37.487] Timer tick, asking Buildbucket for the build status
[00:06:37.629] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:37.629] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:82:0) after 1m0s
[00:07:37.746] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:82:0)
[00:07:37.746] Timer tick, asking Buildbucket for the build status
[00:07:37.920] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:37.920] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:83:0) after 1m0s
[00:08:38.433] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:83:0)
[00:08:38.433] Timer tick, asking Buildbucket for the build status
[00:08:39.417] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:39.417] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:84:0) after 1m0s
[00:09:39.520] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:84:0)
[00:09:39.520] Timer tick, asking Buildbucket for the build status
[00:09:40.098] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:40.098] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:85:0) after 1m0s
[00:10:40.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:85:0)
[00:10:40.119] Timer tick, asking Buildbucket for the build status
[00:10:41.391] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:41.391] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:86:0) after 1m0s
[00:11:41.465] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:86:0)
[00:11:41.465] Timer tick, asking Buildbucket for the build status
[00:11:41.606] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:41.606] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:87:0) after 1m0s
[00:12:41.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:87:0)
[00:12:41.658] Timer tick, asking Buildbucket for the build status
[00:12:41.841] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:41.841] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:88:0) after 1m0s
[00:13:41.877] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:88:0)
[00:13:41.877] Timer tick, asking Buildbucket for the build status
[00:13:42.187] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:42.187] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:89:0) after 1m0s
[00:14:42.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:89:0)
[00:14:42.203] Timer tick, asking Buildbucket for the build status
[00:14:42.787] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:42.787] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:90:0) after 1m0s
[00:15:42.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:90:0)
[00:15:42.832] Timer tick, asking Buildbucket for the build status
[00:15:42.980] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:42.980] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:91:0) after 1m0s
[00:16:43.278] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:91:0)
[00:16:43.278] Timer tick, asking Buildbucket for the build status
[00:16:43.446] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:43.446] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:92:0) after 1m0s
[00:17:43.564] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:92:0)
[00:17:43.564] Timer tick, asking Buildbucket for the build status
[00:17:43.747] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:43.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:93:0) after 1m0s
[00:18:43.801] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:93:0)
[00:18:43.801] Timer tick, asking Buildbucket for the build status
[00:18:43.958] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:43.958] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:94:0) after 1m0s
[00:19:44.034] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:94:0)
[00:19:44.034] Timer tick, asking Buildbucket for the build status
[00:19:44.246] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:44.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:95:0) after 1m0s
[00:20:44.270] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:95:0)
[00:20:44.270] Timer tick, asking Buildbucket for the build status
[00:20:44.691] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:44.691] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:96:0) after 1m0s
[00:21:44.817] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:96:0)
[00:21:44.817] Timer tick, asking Buildbucket for the build status
[00:21:45.257] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:45.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:97:0) after 1m0s
[00:22:45.282] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:97:0)
[00:22:45.282] Timer tick, asking Buildbucket for the build status
[00:22:47.020] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:47.020] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:98:0) after 1m0s
[00:23:47.070] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:98:0)
[00:23:47.070] Timer tick, asking Buildbucket for the build status
[00:23:47.223] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:47.223] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:99:0) after 1m0s
[00:24:47.246] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:99:0)
[00:24:47.246] Timer tick, asking Buildbucket for the build status
[00:24:47.416] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:47.416] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:100:0) after 1m0s
[00:25:47.449] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:100:0)
[00:25:47.449] Timer tick, asking Buildbucket for the build status
[00:25:47.632] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:47.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:101:0) after 1m0s
[00:26:47.647] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:101:0)
[00:26:47.647] Timer tick, asking Buildbucket for the build status
[00:26:48.010] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:48.010] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:102:0) after 1m0s
[00:27:48.096] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:102:0)
[00:27:48.096] Timer tick, asking Buildbucket for the build status
[00:27:48.264] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:48.264] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:103:0) after 1m0s
[00:28:48.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:103:0)
[00:28:48.581] Timer tick, asking Buildbucket for the build status
[00:28:48.751] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:48.751] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:104:0) after 1m0s
[00:29:49.003] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:104:0)
[00:29:49.004] Timer tick, asking Buildbucket for the build status
[00:29:49.169] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:49.169] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:105:0) after 1m0s
[00:30:49.194] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:105:0)
[00:30:49.194] Timer tick, asking Buildbucket for the build status
[00:30:49.334] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:49.334] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:106:0) after 1m0s
[00:31:49.340] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:106:0)
[00:31:49.340] Timer tick, asking Buildbucket for the build status
[00:31:49.777] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:49.777] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:107:0) after 1m0s
[00:32:49.890] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:107:0)
[00:32:49.890] Timer tick, asking Buildbucket for the build status
[00:32:50.014] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:50.014] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:108:0) after 1m0s
[00:33:50.125] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:108:0)
[00:33:50.125] Timer tick, asking Buildbucket for the build status
[00:33:50.260] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:50.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:109:0) after 1m0s
[00:34:50.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:109:0)
[00:34:50.569] Timer tick, asking Buildbucket for the build status
[00:34:50.792] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:50.792] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:110:0) after 1m0s
[00:35:51.015] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:110:0)
[00:35:51.015] Timer tick, asking Buildbucket for the build status
[00:35:51.490] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:51.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:111:0) after 1m0s
[00:36:51.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:111:0)
[00:36:51.774] Timer tick, asking Buildbucket for the build status
[00:36:52.236] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:52.236] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:112:0) after 1m0s
[00:37:52.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:112:0)
[00:37:52.238] Timer tick, asking Buildbucket for the build status
[00:37:52.611] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:52.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:113:0) after 1m0s
[00:38:52.654] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:113:0)
[00:38:52.654] Timer tick, asking Buildbucket for the build status
[00:38:52.886] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:52.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:114:0) after 1m0s
[00:39:53.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:114:0)
[00:39:53.026] Timer tick, asking Buildbucket for the build status
[00:39:53.316] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:53.316] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:115:0) after 1m0s
[00:40:53.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:115:0)
[00:40:53.316] Timer tick, asking Buildbucket for the build status
[00:40:53.574] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:53.574] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:116:0) after 1m0s
[00:41:53.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:116:0)
[00:41:53.702] Timer tick, asking Buildbucket for the build status
[00:41:54.037] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:54.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:117:0) after 1m0s
[00:42:54.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:117:0)
[00:42:54.057] Timer tick, asking Buildbucket for the build status
[00:42:54.228] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:54.228] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:118:0) after 1m0s
[00:43:54.252] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:118:0)
[00:43:54.252] Timer tick, asking Buildbucket for the build status
[00:43:54.500] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:54.500] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:119:0) after 1m0s
[00:44:54.539] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:119:0)
[00:44:54.539] Timer tick, asking Buildbucket for the build status
[00:44:54.724] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:54.724] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:120:0) after 1m0s
[00:45:54.793] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:120:0)
[00:45:54.793] Timer tick, asking Buildbucket for the build status
[00:45:54.987] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:54.987] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:121:0) after 1m0s
[00:46:55.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:121:0)
[00:46:55.272] Timer tick, asking Buildbucket for the build status
[00:46:55.975] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:55.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:122:0) after 1m0s
[00:47:56.486] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:122:0)
[00:47:56.486] Timer tick, asking Buildbucket for the build status
[00:47:56.886] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:56.886] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:123:0) after 1m0s
[00:48:57.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:123:0)
[00:48:57.182] Timer tick, asking Buildbucket for the build status
[00:48:57.347] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:57.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:124:0) after 1m0s
[00:49:57.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:124:0)
[00:49:57.551] Timer tick, asking Buildbucket for the build status
[00:49:57.684] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:57.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:125:0) after 1m0s
[00:50:57.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:125:0)
[00:50:57.938] Timer tick, asking Buildbucket for the build status
[00:50:58.078] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:58.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:126:0) after 1m0s
[00:51:58.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:126:0)
[00:51:58.102] Timer tick, asking Buildbucket for the build status
[00:51:58.281] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:58.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:127:0) after 1m0s
[00:52:58.349] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:127:0)
[00:52:58.349] Timer tick, asking Buildbucket for the build status
[00:52:58.747] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:58.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:128:0) after 1m0s
[00:53:58.787] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:128:0)
[00:53:58.787] Timer tick, asking Buildbucket for the build status
[00:53:59.090] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:59.090] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:129:0) after 1m0s
[00:54:59.446] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:129:0)
[00:54:59.446] Timer tick, asking Buildbucket for the build status
[00:54:59.812] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:59.812] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:130:0) after 1m0s
[00:55:59.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:130:0)
[00:55:59.854] Timer tick, asking Buildbucket for the build status
[00:56:01.579] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:01.579] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:131:0) after 1m0s
[00:57:02.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:131:0)
[00:57:02.308] Timer tick, asking Buildbucket for the build status
[00:57:02.588] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:02.588] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:132:0) after 1m0s
[00:58:02.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:132:0)
[00:58:02.661] Timer tick, asking Buildbucket for the build status
[00:58:02.843] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:02.843] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:133:0) after 1m0s
[00:59:02.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:133:0)
[00:59:02.932] Timer tick, asking Buildbucket for the build status
[00:59:03.286] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:03.286] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:134:0) after 1m0s
[01:00:03.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:134:0)
[01:00:03.323] Timer tick, asking Buildbucket for the build status
[01:00:03.837] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:03.837] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:135:0) after 1m0s
[01:01:03.878] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:135:0)
[01:01:03.878] Timer tick, asking Buildbucket for the build status
[01:01:04.012] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:04.012] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:136:0) after 1m0s
[01:02:04.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:136:0)
[01:02:04.098] Timer tick, asking Buildbucket for the build status
[01:02:05.501] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:05.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:137:0) after 1m0s
[01:03:05.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:137:0)
[01:03:05.574] Timer tick, asking Buildbucket for the build status
[01:03:05.743] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:05.743] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:138:0) after 1m0s
[01:04:05.792] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:138:0)
[01:04:05.792] Timer tick, asking Buildbucket for the build status
[01:04:06.245] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:06.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:139:0) after 1m0s
[01:05:06.280] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:139:0)
[01:05:06.280] Timer tick, asking Buildbucket for the build status
[01:05:06.502] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:06.502] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:140:0) after 1m0s
[01:06:06.572] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:140:0)
[01:06:06.572] Timer tick, asking Buildbucket for the build status
[01:06:07.100] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:07.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:141:0) after 1m0s
[01:07:07.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:141:0)
[01:07:07.189] Timer tick, asking Buildbucket for the build status
[01:07:07.497] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:07.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:142:0) after 1m0s
[01:08:07.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:142:0)
[01:08:07.558] Timer tick, asking Buildbucket for the build status
[01:08:07.761] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:07.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:143:0) after 1m0s
[01:09:07.932] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:143:0)
[01:09:07.932] Timer tick, asking Buildbucket for the build status
[01:09:08.086] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:08.086] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:144:0) after 1m0s
[01:10:08.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:144:0)
[01:10:08.199] Timer tick, asking Buildbucket for the build status
[01:10:08.396] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:08.396] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:145:0) after 1m0s
[01:11:08.453] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:145:0)
[01:11:08.453] Timer tick, asking Buildbucket for the build status
[01:11:08.764] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:08.764] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:146:0) after 1m0s
[01:12:08.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:146:0)
[01:12:08.921] Timer tick, asking Buildbucket for the build status
[01:12:10.293] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:10.294] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:147:0) after 1m0s
[01:13:10.323] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:147:0)
[01:13:10.323] Timer tick, asking Buildbucket for the build status
[01:13:10.515] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:10.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:148:0) after 1m0s
[01:14:10.582] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:148:0)
[01:14:10.582] Timer tick, asking Buildbucket for the build status
[01:14:10.771] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:10.771] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:149:0) after 1m0s
[01:15:10.771] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:149:0)
[01:15:10.771] Timer tick, asking Buildbucket for the build status
[01:15:10.942] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:10.942] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:150:0) after 1m0s
[01:16:11.056] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:150:0)
[01:16:11.056] Timer tick, asking Buildbucket for the build status
[01:16:11.310] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:11.310] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:151:0) after 1m0s
[01:17:11.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:151:0)
[01:17:11.364] Timer tick, asking Buildbucket for the build status
[01:17:11.490] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:11.490] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:152:0) after 1m0s
[01:18:11.551] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:152:0)
[01:18:11.551] Timer tick, asking Buildbucket for the build status
[01:18:12.151] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:12.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:153:0) after 1m0s
[01:19:12.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:153:0)
[01:19:12.373] Timer tick, asking Buildbucket for the build status
[01:19:12.597] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:12.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:154:0) after 1m0s
[01:20:12.718] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:154:0)
[01:20:12.718] Timer tick, asking Buildbucket for the build status
[01:20:12.913] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:12.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:155:0) after 1m0s
[01:21:13.013] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:155:0)
[01:21:13.013] Timer tick, asking Buildbucket for the build status
[01:21:13.246] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:13.246] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:156:0) after 1m0s
[01:22:13.296] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:156:0)
[01:22:13.296] Timer tick, asking Buildbucket for the build status
[01:22:13.429] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:13.429] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:157:0) after 1m0s
[01:23:13.569] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:157:0)
[01:23:13.569] Timer tick, asking Buildbucket for the build status
[01:23:13.694] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:13.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:158:0) after 1m0s
[01:24:13.822] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:158:0)
[01:24:13.822] Timer tick, asking Buildbucket for the build status
[01:24:13.969] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:13.969] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:159:0) after 1m0s
[01:25:13.997] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:159:0)
[01:25:13.997] Timer tick, asking Buildbucket for the build status
[01:25:14.195] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:14.195] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:160:0) after 1m0s
[01:26:14.239] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:160:0)
[01:26:14.239] Timer tick, asking Buildbucket for the build status
[01:26:14.451] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:14.451] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:161:0) after 1m0s
[01:27:14.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:161:0)
[01:27:14.503] Timer tick, asking Buildbucket for the build status
[01:27:14.612] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:14.612] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:162:0) after 1m0s
[01:28:14.670] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:162:0)
[01:28:14.670] Timer tick, asking Buildbucket for the build status
[01:28:15.148] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:15.148] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:163:0) after 1m0s
[01:29:15.261] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:163:0)
[01:29:15.261] Timer tick, asking Buildbucket for the build status
[01:29:15.578] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:15.578] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:164:0) after 1m0s
[01:30:15.653] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:164:0)
[01:30:15.653] Timer tick, asking Buildbucket for the build status
[01:30:15.821] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:15.821] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:165:0) after 1m0s
[01:31:15.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:165:0)
[01:31:15.859] Timer tick, asking Buildbucket for the build status
[01:31:17.037] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:17.037] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:166:0) after 1m0s
[01:32:17.692] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:166:0)
[01:32:17.692] Timer tick, asking Buildbucket for the build status
[01:32:17.891] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:17.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:167:0) after 1m0s
[01:33:17.933] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:167:0)
[01:33:17.933] Timer tick, asking Buildbucket for the build status
[01:33:18.189] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:18.189] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:168:0) after 1m0s
[01:34:18.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:168:0)
[01:34:18.364] Timer tick, asking Buildbucket for the build status
[01:34:18.547] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:18.547] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:169:0) after 1m0s
[01:35:18.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:169:0)
[01:35:18.605] Timer tick, asking Buildbucket for the build status
[01:35:18.970] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:18.970] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:170:0) after 1m0s
[01:36:19.029] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:170:0)
[01:36:19.029] Timer tick, asking Buildbucket for the build status
[01:36:19.459] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:19.459] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:171:0) after 1m0s
[01:37:19.529] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:171:0)
[01:37:19.529] Timer tick, asking Buildbucket for the build status
[01:37:26.323] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:26.323] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:172:0) after 1m0s
[01:38:26.416] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:172:0)
[01:38:26.416] Timer tick, asking Buildbucket for the build status
[01:38:26.532] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:26.532] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:173:0) after 1m0s
[01:39:26.602] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:173:0)
[01:39:26.602] Timer tick, asking Buildbucket for the build status
[01:39:27.039] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:27.039] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:174:0) after 1m0s
[01:40:27.069] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:174:0)
[01:40:27.070] Timer tick, asking Buildbucket for the build status
[01:40:27.259] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:27.260] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:175:0) after 1m0s
[01:41:27.364] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:175:0)
[01:41:27.364] Timer tick, asking Buildbucket for the build status
[01:41:27.523] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:27.523] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:176:0) after 1m0s
[01:42:27.558] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:176:0)
[01:42:27.558] Timer tick, asking Buildbucket for the build status
[01:42:27.709] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:27.709] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:177:0) after 1m0s
[01:43:27.750] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:177:0)
[01:43:27.750] Timer tick, asking Buildbucket for the build status
[01:43:27.944] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:27.944] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:178:0) after 1m0s
[01:44:28.043] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:178:0)
[01:44:28.043] Timer tick, asking Buildbucket for the build status
[01:44:28.244] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:28.244] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:179:0) after 1m0s
[01:45:28.302] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:179:0)
[01:45:28.302] Timer tick, asking Buildbucket for the build status
[01:45:28.421] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:28.421] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:180:0) after 1m0s
[01:46:28.477] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:180:0)
[01:46:28.477] Timer tick, asking Buildbucket for the build status
[01:46:28.907] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:28.907] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:181:0) after 1m0s
[01:47:28.992] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:181:0)
[01:47:28.992] Timer tick, asking Buildbucket for the build status
[01:47:29.126] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:29.126] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:182:0) after 1m0s
[01:48:29.146] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:182:0)
[01:48:29.146] Timer tick, asking Buildbucket for the build status
[01:48:29.762] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:29.762] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:183:0) after 1m0s
[01:49:29.838] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:183:0)
[01:49:29.838] Timer tick, asking Buildbucket for the build status
[01:49:29.972] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:29.972] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:184:0) after 1m0s
[01:50:29.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:184:0)
[01:50:29.986] Timer tick, asking Buildbucket for the build status
[01:50:30.165] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:30.165] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:185:0) after 1m0s
[01:51:30.266] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:185:0)
[01:51:30.266] Timer tick, asking Buildbucket for the build status
[01:51:30.497] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:30.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:186:0) after 1m0s
[01:52:30.547] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:186:0)
[01:52:30.547] Timer tick, asking Buildbucket for the build status
[01:52:30.725] Build 8875303091063401984: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:30.725] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9040733153291464752:187:0) after 1m0s
[01:53:13.991] Received PubSub notification, asking Buildbucket for the build status
[01:53:14.065] Build 8875303091063401984: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:53:14.065] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1594259592952181",
"created_by": "project:infra",
"created_ts": "1594248413939548",
"id": "8875303091063401984",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4183.15\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"6d4553bb-ea66-4d80-b4ae-f6691530dd84\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4183.15\"}}",
"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-nrxe\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.infra.cron\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594248444099444",
"status": "COMPLETED",
"status_changed_ts": "1594259593692289",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9040733153291464752",
"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/8875303091063401984/+/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:4d496dccd1cd2b10",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1594259593707625",
"url": "https://ci.chromium.org/b/8875303091063401984",
"utcnow_ts": "1594259594055791"
}
}
[01:53:14.065] Invocation finished in 3h6m21.633866183s with status SUCCEEDED