[03:10:52.922] New invocation is queued and will start shortly
[03:10:52.923] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[03:10:54.943] Starting the invocation (attempt 1)
[03:10:54.990] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:10:54.990] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:10:54.991] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9044521615942849504",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"buildbucket\":{\"properties\":{\"version\":\"85.0.4157.4\"},\"tags\":[\"parent_buildername:publish_tarball\",\"user_agent:recipe\"]},\"id\":\"7d49d8f3-a7aa-43e5-ad4f-edb669bd30df\",\"title\":\"publish_tarball/0\"}]},\"version\":\"85.0.4157.4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9044521615942849504",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[03:10:56.031] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1590635455174872",
"id": "8879091552913769520",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4157.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7d49d8f3-a7aa-43e5-ad4f-edb669bd30df\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4157.4\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1590635455642043",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9044521615942849504",
"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/8879091552913769520/+/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": "1590635455645266",
"url": "https://ci.chromium.org/b/8879091552913769520",
"utcnow_ts": "1590635456015815"
}
}
[03:10:56.031] Task URL: https://ci.chromium.org/b/8879091552913769520
[03:10:56.031] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:2:0) after 1m0s
[03:11:56.856] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:2:0)
[03:11:56.856] Timer tick, asking Buildbucket for the build status
[03:11:57.105] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:11:57.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:3:0) after 1m0s
[03:12:57.251] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:3:0)
[03:12:57.251] Timer tick, asking Buildbucket for the build status
[03:12:57.427] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:12:57.427] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:4:0) after 1m0s
[03:13:57.535] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:4:0)
[03:13:57.535] Timer tick, asking Buildbucket for the build status
[03:13:57.903] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:13:57.903] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:5:0) after 1m0s
[03:14:57.996] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:5:0)
[03:14:57.996] Timer tick, asking Buildbucket for the build status
[03:14:59.345] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:14:59.345] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:6:0) after 1m0s
[03:15:59.487] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:6:0)
[03:15:59.487] Timer tick, asking Buildbucket for the build status
[03:16:00.464] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:16:00.464] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:7:0) after 1m0s
[03:17:01.205] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:7:0)
[03:17:01.205] Timer tick, asking Buildbucket for the build status
[03:17:01.885] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:17:01.885] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:8:0) after 1m0s
[03:18:03.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:8:0)
[03:18:03.648] Timer tick, asking Buildbucket for the build status
[03:18:03.900] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:18:03.900] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:9:0) after 1m0s
[03:19:04.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:9:0)
[03:19:04.007] Timer tick, asking Buildbucket for the build status
[03:19:04.343] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:19:04.343] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:10:0) after 1m0s
[03:20:04.394] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:10:0)
[03:20:04.394] Timer tick, asking Buildbucket for the build status
[03:20:04.544] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:20:04.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:11:0) after 1m0s
[03:21:04.684] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:11:0)
[03:21:04.684] Timer tick, asking Buildbucket for the build status
[03:21:05.986] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:21:05.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:12:0) after 1m0s
[03:22:06.189] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:12:0)
[03:22:06.189] Timer tick, asking Buildbucket for the build status
[03:22:06.531] Build 8879091552913769520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:22:06.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:13:0) after 1m0s
[03:22:32.502] Received PubSub notification, asking Buildbucket for the build status
[03:22:32.666] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:06.601] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:13:0)
[03:23:06.601] Timer tick, asking Buildbucket for the build status
[03:23:06.773] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:06.773] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:15:0) after 1m0s
[03:24:06.862] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:15:0)
[03:24:06.862] Timer tick, asking Buildbucket for the build status
[03:24:07.048] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:07.048] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:16:0) after 1m0s
[03:25:07.089] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:16:0)
[03:25:07.089] Timer tick, asking Buildbucket for the build status
[03:25:07.675] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:07.675] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:17:0) after 1m0s
[03:26:07.716] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:17:0)
[03:26:07.716] Timer tick, asking Buildbucket for the build status
[03:26:08.104] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:08.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:18:0) after 1m0s
[03:27:08.156] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:18:0)
[03:27:08.156] Timer tick, asking Buildbucket for the build status
[03:27:08.679] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:08.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:19:0) after 1m0s
[03:28:08.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:19:0)
[03:28:08.662] Timer tick, asking Buildbucket for the build status
[03:28:08.827] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:08.827] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:20:0) after 1m0s
[03:29:08.907] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:20:0)
[03:29:08.907] Timer tick, asking Buildbucket for the build status
[03:29:09.033] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:09.033] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:21:0) after 1m0s
[03:30:09.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:21:0)
[03:30:09.554] Timer tick, asking Buildbucket for the build status
[03:30:09.717] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:09.717] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:22:0) after 1m0s
[03:31:10.764] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:22:0)
[03:31:10.764] Timer tick, asking Buildbucket for the build status
[03:31:11.100] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:11.100] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:23:0) after 1m0s
[03:32:11.195] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:23:0)
[03:32:11.195] Timer tick, asking Buildbucket for the build status
[03:32:11.440] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:11.440] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:24:0) after 1m0s
[03:33:11.542] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:24:0)
[03:33:11.542] Timer tick, asking Buildbucket for the build status
[03:33:12.077] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:12.077] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:25:0) after 1m0s
[03:34:12.104] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:25:0)
[03:34:12.104] Timer tick, asking Buildbucket for the build status
[03:34:12.489] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:12.489] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:26:0) after 1m0s
[03:35:12.623] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:26:0)
[03:35:12.623] Timer tick, asking Buildbucket for the build status
[03:35:12.780] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:12.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:27:0) after 1m0s
[03:36:12.783] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:27:0)
[03:36:12.783] Timer tick, asking Buildbucket for the build status
[03:36:13.450] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:13.450] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:28:0) after 1m0s
[03:37:13.854] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:28:0)
[03:37:13.854] Timer tick, asking Buildbucket for the build status
[03:37:14.089] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:14.089] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:29:0) after 1m0s
[03:38:14.149] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:29:0)
[03:38:14.149] Timer tick, asking Buildbucket for the build status
[03:38:14.627] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:14.627] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:30:0) after 1m0s
[03:39:14.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:30:0)
[03:39:14.901] Timer tick, asking Buildbucket for the build status
[03:39:15.204] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:15.204] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:31:0) after 1m0s
[03:40:15.381] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:31:0)
[03:40:15.381] Timer tick, asking Buildbucket for the build status
[03:40:15.616] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:15.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:32:0) after 1m0s
[03:41:15.688] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:32:0)
[03:41:15.688] Timer tick, asking Buildbucket for the build status
[03:41:17.678] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:17.678] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:33:0) after 1m0s
[03:42:17.938] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:33:0)
[03:42:17.938] Timer tick, asking Buildbucket for the build status
[03:42:18.231] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:18.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:34:0) after 1m0s
[03:43:18.398] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:34:0)
[03:43:18.398] Timer tick, asking Buildbucket for the build status
[03:43:18.793] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:18.793] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:35:0) after 1m0s
[03:44:18.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:35:0)
[03:44:18.970] Timer tick, asking Buildbucket for the build status
[03:44:19.300] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:19.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:36:0) after 1m0s
[03:45:19.466] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:36:0)
[03:45:19.466] Timer tick, asking Buildbucket for the build status
[03:45:19.790] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:19.790] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:37:0) after 1m0s
[03:46:20.326] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:37:0)
[03:46:20.326] Timer tick, asking Buildbucket for the build status
[03:46:20.779] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:20.779] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:38:0) after 1m0s
[03:47:20.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:38:0)
[03:47:20.953] Timer tick, asking Buildbucket for the build status
[03:47:21.178] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:21.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:39:0) after 1m0s
[03:48:21.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:39:0)
[03:48:21.271] Timer tick, asking Buildbucket for the build status
[03:48:21.641] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:21.641] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:40:0) after 1m0s
[03:49:21.751] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:40:0)
[03:49:21.751] Timer tick, asking Buildbucket for the build status
[03:49:21.911] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:21.911] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:41:0) after 1m0s
[03:50:21.988] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:41:0)
[03:50:21.988] Timer tick, asking Buildbucket for the build status
[03:50:22.174] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:22.174] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:42:0) after 1m0s
[03:51:22.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:42:0)
[03:51:22.295] Timer tick, asking Buildbucket for the build status
[03:51:24.607] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:24.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:43:0) after 1m0s
[03:52:24.879] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:43:0)
[03:52:24.880] Timer tick, asking Buildbucket for the build status
[03:52:25.046] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:25.046] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:44:0) after 1m0s
[03:53:25.061] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:44:0)
[03:53:25.061] Timer tick, asking Buildbucket for the build status
[03:53:26.212] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:26.212] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:45:0) after 1m0s
[03:54:26.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:45:0)
[03:54:26.301] Timer tick, asking Buildbucket for the build status
[03:54:26.554] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:26.554] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:46:0) after 1m0s
[03:55:26.587] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:46:0)
[03:55:26.587] Timer tick, asking Buildbucket for the build status
[03:55:28.061] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:28.061] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:47:0) after 1m0s
[03:56:28.098] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:47:0)
[03:56:28.098] Timer tick, asking Buildbucket for the build status
[03:56:28.241] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:28.241] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:48:0) after 1m0s
[03:57:28.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:48:0)
[03:57:28.367] Timer tick, asking Buildbucket for the build status
[03:57:30.177] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:30.177] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:49:0) after 1m0s
[03:58:30.238] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:49:0)
[03:58:30.238] Timer tick, asking Buildbucket for the build status
[03:58:30.565] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:30.566] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:50:0) after 1m0s
[03:59:30.580] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:50:0)
[03:59:30.580] Timer tick, asking Buildbucket for the build status
[03:59:30.692] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:30.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:51:0) after 1m0s
[04:00:30.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:51:0)
[04:00:30.729] Timer tick, asking Buildbucket for the build status
[04:00:34.005] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:34.005] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:52:0) after 1m0s
[04:01:34.159] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:52:0)
[04:01:34.159] Timer tick, asking Buildbucket for the build status
[04:01:35.735] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:35.735] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:53:0) after 1m0s
[04:02:35.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:53:0)
[04:02:35.776] Timer tick, asking Buildbucket for the build status
[04:02:35.976] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:35.976] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:54:0) after 1m0s
[04:03:36.066] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:54:0)
[04:03:36.066] Timer tick, asking Buildbucket for the build status
[04:03:36.458] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:36.458] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:55:0) after 1m0s
[04:04:36.540] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:55:0)
[04:04:36.540] Timer tick, asking Buildbucket for the build status
[04:04:37.311] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:37.311] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:56:0) after 1m0s
[04:05:37.344] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:56:0)
[04:05:37.344] Timer tick, asking Buildbucket for the build status
[04:05:37.902] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:37.902] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:57:0) after 1m0s
[04:06:37.984] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:57:0)
[04:06:37.984] Timer tick, asking Buildbucket for the build status
[04:06:38.905] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:38.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:58:0) after 1m0s
[04:07:38.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:58:0)
[04:07:38.926] Timer tick, asking Buildbucket for the build status
[04:07:39.096] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:39.096] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:59:0) after 1m0s
[04:08:39.134] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:59:0)
[04:08:39.134] Timer tick, asking Buildbucket for the build status
[04:08:39.636] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:39.636] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:60:0) after 1m0s
[04:09:39.656] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:60:0)
[04:09:39.656] Timer tick, asking Buildbucket for the build status
[04:09:39.783] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:39.783] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:61:0) after 1m0s
[04:10:39.769] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:61:0)
[04:10:39.770] Timer tick, asking Buildbucket for the build status
[04:10:40.151] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:40.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:62:0) after 1m0s
[04:11:40.197] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:62:0)
[04:11:40.197] Timer tick, asking Buildbucket for the build status
[04:11:42.281] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:42.281] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:63:0) after 1m0s
[04:12:42.301] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:63:0)
[04:12:42.301] Timer tick, asking Buildbucket for the build status
[04:12:42.432] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:42.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:64:0) after 1m0s
[04:13:42.480] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:64:0)
[04:13:42.480] Timer tick, asking Buildbucket for the build status
[04:13:42.996] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:42.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:65:0) after 1m0s
[04:14:43.026] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:65:0)
[04:14:43.026] Timer tick, asking Buildbucket for the build status
[04:14:43.261] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:43.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:66:0) after 1m0s
[04:15:43.316] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:66:0)
[04:15:43.316] Timer tick, asking Buildbucket for the build status
[04:15:43.893] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:43.893] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:67:0) after 1m0s
[04:16:43.921] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:67:0)
[04:16:43.921] Timer tick, asking Buildbucket for the build status
[04:16:44.729] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:44.729] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:68:0) after 1m0s
[04:17:44.846] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:68:0)
[04:17:44.846] Timer tick, asking Buildbucket for the build status
[04:17:45.043] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:45.043] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:69:0) after 1m0s
[04:18:45.102] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:69:0)
[04:18:45.102] Timer tick, asking Buildbucket for the build status
[04:18:45.778] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:45.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:70:0) after 1m0s
[04:19:45.851] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:70:0)
[04:19:45.851] Timer tick, asking Buildbucket for the build status
[04:19:46.036] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:46.036] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:71:0) after 1m0s
[04:20:46.126] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:71:0)
[04:20:46.126] Timer tick, asking Buildbucket for the build status
[04:20:46.608] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:46.608] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:72:0) after 1m0s
[04:21:46.632] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:72:0)
[04:21:46.632] Timer tick, asking Buildbucket for the build status
[04:21:46.824] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:46.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:73:0) after 1m0s
[04:22:46.859] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:73:0)
[04:22:46.859] Timer tick, asking Buildbucket for the build status
[04:22:47.245] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:47.245] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:74:0) after 1m0s
[04:23:47.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:74:0)
[04:23:47.272] Timer tick, asking Buildbucket for the build status
[04:23:47.611] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:47.611] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:75:0) after 1m0s
[04:24:47.639] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:75:0)
[04:24:47.639] Timer tick, asking Buildbucket for the build status
[04:24:48.132] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:48.132] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:76:0) after 1m0s
[04:25:48.191] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:76:0)
[04:25:48.191] Timer tick, asking Buildbucket for the build status
[04:25:49.290] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:49.290] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:77:0) after 1m0s
[04:26:49.312] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:77:0)
[04:26:49.312] Timer tick, asking Buildbucket for the build status
[04:26:49.666] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:49.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:78:0) after 1m0s
[04:27:49.694] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:78:0)
[04:27:49.694] Timer tick, asking Buildbucket for the build status
[04:27:50.632] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:50.632] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:79:0) after 1m0s
[04:28:50.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:79:0)
[04:28:50.659] Timer tick, asking Buildbucket for the build status
[04:28:50.895] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:50.895] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:80:0) after 1m0s
[04:29:50.957] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:80:0)
[04:29:50.957] Timer tick, asking Buildbucket for the build status
[04:29:52.220] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:52.220] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:81:0) after 1m0s
[04:30:52.274] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:81:0)
[04:30:52.274] Timer tick, asking Buildbucket for the build status
[04:30:52.860] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:52.860] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:82:0) after 1m0s
[04:31:53.021] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:82:0)
[04:31:53.021] Timer tick, asking Buildbucket for the build status
[04:31:54.631] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:54.631] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:83:0) after 1m0s
[04:32:54.677] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:83:0)
[04:32:54.677] Timer tick, asking Buildbucket for the build status
[04:32:54.880] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:54.880] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:84:0) after 1m0s
[04:33:54.897] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:84:0)
[04:33:54.897] Timer tick, asking Buildbucket for the build status
[04:33:55.070] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:55.070] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:85:0) after 1m0s
[04:34:55.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:85:0)
[04:34:55.161] Timer tick, asking Buildbucket for the build status
[04:34:55.316] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:55.317] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:86:0) after 1m0s
[04:35:55.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:86:0)
[04:35:55.369] Timer tick, asking Buildbucket for the build status
[04:35:56.670] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:56.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:87:0) after 1m0s
[04:36:56.707] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:87:0)
[04:36:56.707] Timer tick, asking Buildbucket for the build status
[04:36:58.142] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:58.142] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:88:0) after 1m0s
[04:37:58.253] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:88:0)
[04:37:58.253] Timer tick, asking Buildbucket for the build status
[04:37:58.596] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:58.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:89:0) after 1m0s
[04:38:58.709] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:89:0)
[04:38:58.709] Timer tick, asking Buildbucket for the build status
[04:38:59.104] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:59.104] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:90:0) after 1m0s
[04:39:59.198] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:90:0)
[04:39:59.198] Timer tick, asking Buildbucket for the build status
[04:39:59.432] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:59.432] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:91:0) after 1m0s
[04:40:59.454] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:91:0)
[04:40:59.454] Timer tick, asking Buildbucket for the build status
[04:41:00.229] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:00.229] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:92:0) after 1m0s
[04:42:00.297] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:92:0)
[04:42:00.297] Timer tick, asking Buildbucket for the build status
[04:42:00.471] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:00.471] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:93:0) after 1m0s
[04:43:00.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:93:0)
[04:43:00.523] Timer tick, asking Buildbucket for the build status
[04:43:00.795] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:00.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:94:0) after 1m0s
[04:44:00.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:94:0)
[04:44:00.861] Timer tick, asking Buildbucket for the build status
[04:44:01.576] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:01.576] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:95:0) after 1m0s
[04:45:02.396] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:95:0)
[04:45:02.396] Timer tick, asking Buildbucket for the build status
[04:45:02.652] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:02.652] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:96:0) after 1m0s
[04:46:02.725] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:96:0)
[04:46:02.725] Timer tick, asking Buildbucket for the build status
[04:46:02.931] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:02.931] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:97:0) after 1m0s
[04:47:03.438] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:97:0)
[04:47:03.438] Timer tick, asking Buildbucket for the build status
[04:47:03.625] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:03.625] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:98:0) after 1m0s
[04:48:03.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:98:0)
[04:48:03.664] Timer tick, asking Buildbucket for the build status
[04:48:03.890] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:03.890] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:99:0) after 1m0s
[04:49:04.004] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:99:0)
[04:49:04.004] Timer tick, asking Buildbucket for the build status
[04:49:04.153] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:04.153] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:100:0) after 1m0s
[04:50:04.130] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:100:0)
[04:50:04.130] Timer tick, asking Buildbucket for the build status
[04:50:04.467] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:04.467] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:101:0) after 1m0s
[04:51:04.508] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:101:0)
[04:51:04.508] Timer tick, asking Buildbucket for the build status
[04:51:04.809] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:04.809] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:102:0) after 1m0s
[04:52:05.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:102:0)
[04:52:05.057] Timer tick, asking Buildbucket for the build status
[04:52:05.216] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:05.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:103:0) after 1m0s
[04:53:05.276] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:103:0)
[04:53:05.276] Timer tick, asking Buildbucket for the build status
[04:53:05.597] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:05.597] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:104:0) after 1m0s
[04:54:05.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:104:0)
[04:54:05.625] Timer tick, asking Buildbucket for the build status
[04:54:05.782] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:05.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:105:0) after 1m0s
[04:55:05.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:105:0)
[04:55:05.849] Timer tick, asking Buildbucket for the build status
[04:55:06.216] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:06.216] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:106:0) after 1m0s
[04:56:06.260] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:106:0)
[04:56:06.260] Timer tick, asking Buildbucket for the build status
[04:56:06.649] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:06.649] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:107:0) after 1m0s
[04:57:06.712] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:107:0)
[04:57:06.712] Timer tick, asking Buildbucket for the build status
[04:57:06.839] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:06.839] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:108:0) after 1m0s
[04:58:06.886] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:108:0)
[04:58:06.886] Timer tick, asking Buildbucket for the build status
[04:58:07.602] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:07.602] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:109:0) after 1m0s
[04:59:07.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:109:0)
[04:59:07.644] Timer tick, asking Buildbucket for the build status
[04:59:07.986] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:07.986] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:110:0) after 1m0s
[05:00:08.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:110:0)
[05:00:08.014] Timer tick, asking Buildbucket for the build status
[05:00:08.382] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:08.382] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:111:0) after 1m0s
[05:01:08.560] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:111:0)
[05:01:08.560] Timer tick, asking Buildbucket for the build status
[05:01:08.716] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:08.716] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:112:0) after 1m0s
[05:02:08.800] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:112:0)
[05:02:08.800] Timer tick, asking Buildbucket for the build status
[05:02:09.428] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:09.428] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:113:0) after 1m0s
[05:03:09.501] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:113:0)
[05:03:09.501] Timer tick, asking Buildbucket for the build status
[05:03:09.948] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:09.948] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:114:0) after 1m0s
[05:04:10.108] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:114:0)
[05:04:10.108] Timer tick, asking Buildbucket for the build status
[05:04:10.324] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:10.324] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:115:0) after 1m0s
[05:05:10.452] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:115:0)
[05:05:10.452] Timer tick, asking Buildbucket for the build status
[05:05:10.957] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:10.957] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:116:0) after 1m0s
[05:06:11.007] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:116:0)
[05:06:11.007] Timer tick, asking Buildbucket for the build status
[05:06:11.505] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:11.505] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:117:0) after 1m0s
[05:07:11.566] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:117:0)
[05:07:11.566] Timer tick, asking Buildbucket for the build status
[05:07:11.747] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:11.747] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:118:0) after 1m0s
[05:08:11.823] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:118:0)
[05:08:11.823] Timer tick, asking Buildbucket for the build status
[05:08:12.296] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:12.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:119:0) after 1m0s
[05:09:12.359] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:119:0)
[05:09:12.359] Timer tick, asking Buildbucket for the build status
[05:09:12.613] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:12.613] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:120:0) after 1m0s
[05:10:12.644] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:120:0)
[05:10:12.644] Timer tick, asking Buildbucket for the build status
[05:10:12.817] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:12.817] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:121:0) after 1m0s
[05:11:12.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:121:0)
[05:11:12.858] Timer tick, asking Buildbucket for the build status
[05:11:13.779] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:13.780] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:122:0) after 1m0s
[05:12:13.803] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:122:0)
[05:12:13.803] Timer tick, asking Buildbucket for the build status
[05:12:13.908] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:13.908] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:123:0) after 1m0s
[05:13:13.947] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:123:0)
[05:13:13.947] Timer tick, asking Buildbucket for the build status
[05:13:14.152] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:14.152] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:124:0) after 1m0s
[05:14:14.203] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:124:0)
[05:14:14.203] Timer tick, asking Buildbucket for the build status
[05:14:14.714] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:14.714] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:125:0) after 1m0s
[05:15:14.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:125:0)
[05:15:14.733] Timer tick, asking Buildbucket for the build status
[05:15:16.257] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:16.257] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:126:0) after 1m0s
[05:16:16.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:126:0)
[05:16:16.290] Timer tick, asking Buildbucket for the build status
[05:16:16.616] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:16.616] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:127:0) after 1m0s
[05:17:16.834] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:127:0)
[05:17:16.834] Timer tick, asking Buildbucket for the build status
[05:17:17.008] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:17.008] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:128:0) after 1m0s
[05:18:17.035] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:128:0)
[05:18:17.035] Timer tick, asking Buildbucket for the build status
[05:18:17.569] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:17.569] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:129:0) after 1m0s
[05:19:17.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:129:0)
[05:19:17.658] Timer tick, asking Buildbucket for the build status
[05:19:17.823] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:17.823] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:130:0) after 1m0s
[05:20:17.926] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:130:0)
[05:20:17.926] Timer tick, asking Buildbucket for the build status
[05:20:18.162] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:18.162] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:131:0) after 1m0s
[05:21:18.383] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:131:0)
[05:21:18.383] Timer tick, asking Buildbucket for the build status
[05:21:21.617] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:21.617] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:132:0) after 1m0s
[05:22:22.511] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:132:0)
[05:22:22.511] Timer tick, asking Buildbucket for the build status
[05:22:24.154] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:24.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:133:0) after 1m0s
[05:23:24.411] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:133:0)
[05:23:24.411] Timer tick, asking Buildbucket for the build status
[05:23:24.861] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:24.861] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:134:0) after 1m0s
[05:24:25.006] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:134:0)
[05:24:25.006] Timer tick, asking Buildbucket for the build status
[05:24:25.289] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:25.289] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:135:0) after 1m0s
[05:25:25.406] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:135:0)
[05:25:25.406] Timer tick, asking Buildbucket for the build status
[05:25:25.553] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:25.553] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:136:0) after 1m0s
[05:26:25.662] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:136:0)
[05:26:25.662] Timer tick, asking Buildbucket for the build status
[05:26:25.761] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:25.761] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:137:0) after 1m0s
[05:27:25.861] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:137:0)
[05:27:25.861] Timer tick, asking Buildbucket for the build status
[05:27:26.017] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:26.017] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:138:0) after 1m0s
[05:28:26.295] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:138:0)
[05:28:26.295] Timer tick, asking Buildbucket for the build status
[05:28:26.679] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:26.679] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:139:0) after 1m0s
[05:29:26.782] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:139:0)
[05:29:26.782] Timer tick, asking Buildbucket for the build status
[05:29:27.795] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:27.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:140:0) after 1m0s
[05:30:27.827] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:140:0)
[05:30:27.827] Timer tick, asking Buildbucket for the build status
[05:30:32.924] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:32.924] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:141:0) after 1m0s
[05:31:33.027] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:141:0)
[05:31:33.027] Timer tick, asking Buildbucket for the build status
[05:31:35.466] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:35.466] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:142:0) after 1m0s
[05:32:35.503] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:142:0)
[05:32:35.503] Timer tick, asking Buildbucket for the build status
[05:32:35.782] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:35.782] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:143:0) after 1m0s
[05:33:35.868] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:143:0)
[05:33:35.868] Timer tick, asking Buildbucket for the build status
[05:33:35.968] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:35.968] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:144:0) after 1m0s
[05:34:36.032] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:144:0)
[05:34:36.032] Timer tick, asking Buildbucket for the build status
[05:34:36.146] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:36.146] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:145:0) after 1m0s
[05:35:36.182] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:145:0)
[05:35:36.183] Timer tick, asking Buildbucket for the build status
[05:35:39.111] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:39.111] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:146:0) after 1m0s
[05:36:39.213] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:146:0)
[05:36:39.213] Timer tick, asking Buildbucket for the build status
[05:36:39.533] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:39.533] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:147:0) after 1m0s
[05:37:39.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:147:0)
[05:37:39.635] Timer tick, asking Buildbucket for the build status
[05:37:39.991] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:39.991] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:148:0) after 1m0s
[05:38:40.148] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:148:0)
[05:38:40.148] Timer tick, asking Buildbucket for the build status
[05:38:40.479] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:40.479] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:149:0) after 1m0s
[05:39:40.561] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:149:0)
[05:39:40.561] Timer tick, asking Buildbucket for the build status
[05:39:41.701] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:41.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:150:0) after 1m0s
[05:40:41.733] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:150:0)
[05:40:41.733] Timer tick, asking Buildbucket for the build status
[05:40:42.139] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:42.139] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:151:0) after 1m0s
[05:41:42.230] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:151:0)
[05:41:42.230] Timer tick, asking Buildbucket for the build status
[05:41:42.330] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:42.330] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:152:0) after 1m0s
[05:42:42.384] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:152:0)
[05:42:42.384] Timer tick, asking Buildbucket for the build status
[05:42:42.515] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:42.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:153:0) after 1m0s
[05:43:42.661] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:153:0)
[05:43:42.661] Timer tick, asking Buildbucket for the build status
[05:43:42.873] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:42.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:154:0) after 1m0s
[05:44:42.913] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:154:0)
[05:44:42.913] Timer tick, asking Buildbucket for the build status
[05:44:43.154] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:43.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:155:0) after 1m0s
[05:45:43.247] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:155:0)
[05:45:43.247] Timer tick, asking Buildbucket for the build status
[05:45:45.913] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:45.913] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:156:0) after 1m0s
[05:46:45.977] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:156:0)
[05:46:45.977] Timer tick, asking Buildbucket for the build status
[05:46:46.131] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:46.131] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:157:0) after 1m0s
[05:47:46.186] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:157:0)
[05:47:46.186] Timer tick, asking Buildbucket for the build status
[05:47:46.694] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:46.694] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:158:0) after 1m0s
[05:48:46.728] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:158:0)
[05:48:46.728] Timer tick, asking Buildbucket for the build status
[05:48:46.910] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:46.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:159:0) after 1m0s
[05:49:47.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:159:0)
[05:49:47.085] Timer tick, asking Buildbucket for the build status
[05:49:47.285] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:47.285] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:160:0) after 1m0s
[05:50:47.358] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:160:0)
[05:50:47.358] Timer tick, asking Buildbucket for the build status
[05:50:56.577] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:56.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:161:0) after 1m0s
[05:51:56.789] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:161:0)
[05:51:56.789] Timer tick, asking Buildbucket for the build status
[05:51:56.973] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:56.973] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:162:0) after 1m0s
[05:52:57.143] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:162:0)
[05:52:57.143] Timer tick, asking Buildbucket for the build status
[05:52:57.252] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:57.252] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:163:0) after 1m0s
[05:53:57.328] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:163:0)
[05:53:57.328] Timer tick, asking Buildbucket for the build status
[05:53:57.647] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:57.650] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:164:0) after 1m0s
[05:54:59.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:164:0)
[05:54:59.084] Timer tick, asking Buildbucket for the build status
[05:54:59.214] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:59.214] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:165:0) after 1m0s
[05:55:59.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:165:0)
[05:55:59.241] Timer tick, asking Buildbucket for the build status
[05:55:59.424] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:59.424] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:166:0) after 1m0s
[05:56:59.600] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:166:0)
[05:56:59.600] Timer tick, asking Buildbucket for the build status
[05:56:59.804] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:59.804] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:167:0) after 1m0s
[05:57:59.849] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:167:0)
[05:57:59.849] Timer tick, asking Buildbucket for the build status
[05:58:00.150] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:00.150] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:168:0) after 1m0s
[05:59:00.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:168:0)
[05:59:00.281] Timer tick, asking Buildbucket for the build status
[05:59:01.023] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:01.023] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:169:0) after 1m0s
[06:00:01.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:169:0)
[06:00:01.645] Timer tick, asking Buildbucket for the build status
[06:00:02.369] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:02.369] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:170:0) after 1m0s
[06:01:03.554] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:170:0)
[06:01:03.554] Timer tick, asking Buildbucket for the build status
[06:01:03.901] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:03.901] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:171:0) after 1m0s
[06:02:04.705] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:171:0)
[06:02:04.705] Timer tick, asking Buildbucket for the build status
[06:02:05.239] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:05.239] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:172:0) after 1m0s
[06:03:05.369] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:172:0)
[06:03:05.369] Timer tick, asking Buildbucket for the build status
[06:03:05.531] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:05.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:173:0) after 1m0s
[06:04:06.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:173:0)
[06:04:06.116] Timer tick, asking Buildbucket for the build status
[06:04:08.295] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:08.296] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:174:0) after 1m0s
[06:05:08.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:174:0)
[06:05:08.555] Timer tick, asking Buildbucket for the build status
[06:05:08.767] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:08.767] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:175:0) after 1m0s
[06:06:09.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:175:0)
[06:06:09.019] Timer tick, asking Buildbucket for the build status
[06:06:09.233] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:09.233] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:176:0) after 1m0s
[06:07:09.305] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:176:0)
[06:07:09.305] Timer tick, asking Buildbucket for the build status
[06:07:09.543] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:09.543] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:177:0) after 1m0s
[06:08:09.721] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:177:0)
[06:08:09.722] Timer tick, asking Buildbucket for the build status
[06:08:10.154] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:10.154] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:178:0) after 1m0s
[06:09:10.170] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:178:0)
[06:09:10.170] Timer tick, asking Buildbucket for the build status
[06:09:10.871] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:10.871] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:179:0) after 1m0s
[06:10:10.961] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:179:0)
[06:10:10.961] Timer tick, asking Buildbucket for the build status
[06:10:11.301] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:11.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:180:0) after 1m0s
[06:11:11.373] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:180:0)
[06:11:11.373] Timer tick, asking Buildbucket for the build status
[06:11:11.515] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:11.515] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:181:0) after 1m0s
[06:12:11.553] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:181:0)
[06:12:11.553] Timer tick, asking Buildbucket for the build status
[06:12:11.982] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:11.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:182:0) after 1m0s
[06:13:12.064] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:182:0)
[06:13:12.064] Timer tick, asking Buildbucket for the build status
[06:13:12.247] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:12.247] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:183:0) after 1m0s
[06:14:12.456] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:183:0)
[06:14:12.456] Timer tick, asking Buildbucket for the build status
[06:14:12.711] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:12.711] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:184:0) after 1m0s
[06:15:12.953] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:184:0)
[06:15:12.953] Timer tick, asking Buildbucket for the build status
[06:15:15.193] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:15.193] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:185:0) after 1m0s
[06:16:15.256] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:185:0)
[06:16:15.256] Timer tick, asking Buildbucket for the build status
[06:16:15.778] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:15.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:186:0) after 1m0s
[06:17:15.858] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:186:0)
[06:17:15.858] Timer tick, asking Buildbucket for the build status
[06:17:16.078] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:16.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:187:0) after 1m0s
[06:18:16.132] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:187:0)
[06:18:16.132] Timer tick, asking Buildbucket for the build status
[06:18:16.276] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:16.276] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:188:0) after 1m0s
[06:19:16.308] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:188:0)
[06:19:16.308] Timer tick, asking Buildbucket for the build status
[06:19:16.577] Build 8879091552913769520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:16.577] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9044521615942849504:189:0) after 1m0s
[06:20:02.276] Received PubSub notification, asking Buildbucket for the build status
[06:20:02.986] Build 8879091552913769520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:20:02.986] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "PROD",
"completed_ts": "1590646799707139",
"created_by": "project:infra",
"created_ts": "1590635455174872",
"id": "8879091552913769520",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"buildbucket\": {\"properties\": {\"version\": \"85.0.4157.4\"}, \"tags\": [\"parent_buildername:publish_tarball\", \"user_agent:recipe\"]}, \"id\": \"7d49d8f3-a7aa-43e5-ad4f-edb669bd30df\", \"title\": \"publish_tarball/0\"}]}, \"version\": \"85.0.4157.4\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"git\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-infra-cron-xenial-large-0-3h44\"], \"image\": [\"chrome-xenial-20041200-f56df5dd7ad\"], \"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\": [\"5141-b649c1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1590636151605039",
"status": "COMPLETED",
"status_changed_ts": "1590646801074682",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9044521615942849504",
"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/8879091552913769520/+/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:4c7214705b19b510",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1590646801560198",
"url": "https://ci.chromium.org/b/8879091552913769520",
"utcnow_ts": "1590646802968758"
}
}
[06:20:02.986] Invocation finished in 3h9m10.083933055s with status SUCCEEDED