[02:38:32.118] New invocation is queued and will start shortly
[02:38:32.118] Triggered by user:chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com
[02:38:33.256] Starting the invocation (attempt 1)
[02:38:33.300] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:38:33.300] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:38:33.300] Buildbucket request:
{
"bucket": "luci.infra.cron",
"client_operation_id": "9085020495003298432",
"parameters_json": "{\"builder_name\":\"Build From Tarball\",\"properties\":{\"version\":\"74.0.3728.0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Build From Tarball",
"scheduler_invocation_id:9085020495003298432",
"scheduler_job_id:infra/Build From Tarball",
"user_agent:luci-scheduler",
"parent_buildername:publish_tarball",
"user_agent:recipe"
]
}
[02:38:34.676] Buildbucket response:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552012713418801",
"id": "8919590432973503824",
"lease_expiration_ts": "1552131514532104",
"lease_key": "1101553494",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3728.0\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1552012714532693",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085020495003298432",
"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/8919590432973503824/+/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:4373fc2876d4b910",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552012714532814",
"url": "https://ci.chromium.org/b/8919590432973503824",
"utcnow_ts": "1552012714667052"
}
}
[02:38:34.676] Task URL: https://ci.chromium.org/b/8919590432973503824
[02:38:34.676] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:2:0) after 1m0s
[02:39:31.637] Received PubSub notification, asking Buildbucket for the build status
[02:39:31.684] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:34.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:2:0)
[02:39:34.695] Timer tick, asking Buildbucket for the build status
[02:39:34.746] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:34.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:4:0) after 1m0s
[02:40:34.774] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:4:0)
[02:40:34.774] Timer tick, asking Buildbucket for the build status
[02:40:34.824] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:34.824] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:5:0) after 1m0s
[02:41:34.810] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:5:0)
[02:41:34.810] Timer tick, asking Buildbucket for the build status
[02:41:34.982] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:34.982] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:6:0) after 1m0s
[02:42:34.981] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:6:0)
[02:42:34.981] Timer tick, asking Buildbucket for the build status
[02:42:35.105] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:35.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:7:0) after 1m0s
[02:43:35.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:7:0)
[02:43:35.123] Timer tick, asking Buildbucket for the build status
[02:43:35.178] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:35.178] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:8:0) after 1m0s
[02:44:35.180] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:8:0)
[02:44:35.180] Timer tick, asking Buildbucket for the build status
[02:44:35.227] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:35.227] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:9:0) after 1m0s
[02:45:35.241] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:9:0)
[02:45:35.241] Timer tick, asking Buildbucket for the build status
[02:45:35.301] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:35.301] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:10:0) after 1m0s
[02:46:35.311] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:10:0)
[02:46:35.311] Timer tick, asking Buildbucket for the build status
[02:46:35.347] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:35.347] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:11:0) after 1m0s
[02:47:35.321] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:11:0)
[02:47:35.321] Timer tick, asking Buildbucket for the build status
[02:47:35.455] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:35.455] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:12:0) after 1m0s
[02:48:35.427] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:12:0)
[02:48:35.427] Timer tick, asking Buildbucket for the build status
[02:48:35.460] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:35.460] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:13:0) after 1m0s
[02:49:35.472] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:13:0)
[02:49:35.472] Timer tick, asking Buildbucket for the build status
[02:49:35.666] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:35.666] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:14:0) after 1m0s
[02:50:35.659] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:14:0)
[02:50:35.659] Timer tick, asking Buildbucket for the build status
[02:50:35.755] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:35.755] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:15:0) after 1m0s
[02:51:35.777] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:15:0)
[02:51:35.777] Timer tick, asking Buildbucket for the build status
[02:51:35.910] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:35.910] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:16:0) after 1m0s
[02:52:35.930] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:16:0)
[02:52:35.930] Timer tick, asking Buildbucket for the build status
[02:52:35.996] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:35.996] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:17:0) after 1m0s
[02:53:35.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:17:0)
[02:53:35.975] Timer tick, asking Buildbucket for the build status
[02:53:36.020] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:36.021] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:18:0) after 1m0s
[02:54:36.065] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:18:0)
[02:54:36.065] Timer tick, asking Buildbucket for the build status
[02:54:36.113] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:36.113] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:19:0) after 1m0s
[02:55:36.116] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:19:0)
[02:55:36.116] Timer tick, asking Buildbucket for the build status
[02:55:36.268] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:36.268] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:20:0) after 1m0s
[02:56:36.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:20:0)
[02:56:36.289] Timer tick, asking Buildbucket for the build status
[02:56:36.329] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:36.329] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:21:0) after 1m0s
[02:57:36.320] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:21:0)
[02:57:36.320] Timer tick, asking Buildbucket for the build status
[02:57:36.360] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:36.360] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:22:0) after 1m0s
[02:58:36.367] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:22:0)
[02:58:36.367] Timer tick, asking Buildbucket for the build status
[02:58:37.095] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:37.095] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:23:0) after 1m0s
[02:59:37.121] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:23:0)
[02:59:37.121] Timer tick, asking Buildbucket for the build status
[02:59:37.271] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:37.271] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:24:0) after 1m0s
[03:00:37.281] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:24:0)
[03:00:37.282] Timer tick, asking Buildbucket for the build status
[03:00:37.426] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:37.426] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:25:0) after 1m0s
[03:01:37.448] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:25:0)
[03:01:37.448] Timer tick, asking Buildbucket for the build status
[03:01:37.873] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:37.873] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:26:0) after 1m0s
[03:02:37.876] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:26:0)
[03:02:37.876] Timer tick, asking Buildbucket for the build status
[03:02:37.922] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:37.922] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:27:0) after 1m0s
[03:03:37.946] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:27:0)
[03:03:37.946] Timer tick, asking Buildbucket for the build status
[03:03:38.072] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:38.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:28:0) after 1m0s
[03:04:38.085] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:28:0)
[03:04:38.085] Timer tick, asking Buildbucket for the build status
[03:04:38.151] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:38.151] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:29:0) after 1m0s
[03:05:38.214] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:29:0)
[03:05:38.214] Timer tick, asking Buildbucket for the build status
[03:05:38.261] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:38.261] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:30:0) after 1m0s
[03:06:38.279] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:30:0)
[03:06:38.279] Timer tick, asking Buildbucket for the build status
[03:06:38.399] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:38.399] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:31:0) after 1m0s
[03:07:38.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:31:0)
[03:07:38.399] Timer tick, asking Buildbucket for the build status
[03:07:38.568] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:38.568] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:32:0) after 1m0s
[03:08:38.581] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:32:0)
[03:08:38.581] Timer tick, asking Buildbucket for the build status
[03:08:38.684] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:38.684] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:33:0) after 1m0s
[03:09:38.703] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:33:0)
[03:09:38.703] Timer tick, asking Buildbucket for the build status
[03:09:38.746] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:38.746] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:34:0) after 1m0s
[03:10:38.767] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:34:0)
[03:10:38.767] Timer tick, asking Buildbucket for the build status
[03:10:38.820] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:38.820] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:35:0) after 1m0s
[03:11:38.842] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:35:0)
[03:11:38.842] Timer tick, asking Buildbucket for the build status
[03:11:38.896] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:38.896] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:36:0) after 1m0s
[03:12:38.935] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:36:0)
[03:12:38.935] Timer tick, asking Buildbucket for the build status
[03:12:38.992] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:38.992] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:37:0) after 1m0s
[03:13:39.014] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:37:0)
[03:13:39.014] Timer tick, asking Buildbucket for the build status
[03:13:39.058] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:39.058] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:38:0) after 1m0s
[03:14:39.041] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:38:0)
[03:14:39.041] Timer tick, asking Buildbucket for the build status
[03:14:39.101] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:39.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:39:0) after 1m0s
[03:15:39.107] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:39:0)
[03:15:39.107] Timer tick, asking Buildbucket for the build status
[03:15:39.349] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:39.349] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:40:0) after 1m0s
[03:16:39.401] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:40:0)
[03:16:39.401] Timer tick, asking Buildbucket for the build status
[03:16:39.501] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:39.501] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:41:0) after 1m0s
[03:17:39.496] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:41:0)
[03:17:39.496] Timer tick, asking Buildbucket for the build status
[03:17:39.662] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:39.662] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:42:0) after 1m0s
[03:18:39.658] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:42:0)
[03:18:39.658] Timer tick, asking Buildbucket for the build status
[03:18:39.704] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:39.704] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:43:0) after 1m0s
[03:19:39.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:43:0)
[03:19:39.702] Timer tick, asking Buildbucket for the build status
[03:19:39.795] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:39.795] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:44:0) after 1m0s
[03:20:39.776] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:44:0)
[03:20:39.776] Timer tick, asking Buildbucket for the build status
[03:20:40.103] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:40.103] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:45:0) after 1m0s
[03:21:40.123] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:45:0)
[03:21:40.123] Timer tick, asking Buildbucket for the build status
[03:21:40.179] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:40.179] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:46:0) after 1m0s
[03:22:40.199] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:46:0)
[03:22:40.199] Timer tick, asking Buildbucket for the build status
[03:22:40.259] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:40.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:47:0) after 1m0s
[03:23:40.277] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:47:0)
[03:23:40.277] Timer tick, asking Buildbucket for the build status
[03:23:40.322] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:40.322] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:48:0) after 1m0s
[03:24:40.343] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:48:0)
[03:24:40.343] Timer tick, asking Buildbucket for the build status
[03:24:40.394] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:40.394] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:49:0) after 1m0s
[03:25:40.403] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:49:0)
[03:25:40.403] Timer tick, asking Buildbucket for the build status
[03:25:40.607] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:40.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:50:0) after 1m0s
[03:26:40.584] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:50:0)
[03:26:40.585] Timer tick, asking Buildbucket for the build status
[03:26:40.701] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:40.701] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:51:0) after 1m0s
[03:27:40.729] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:51:0)
[03:27:40.729] Timer tick, asking Buildbucket for the build status
[03:27:40.891] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:40.891] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:52:0) after 1m0s
[03:28:40.883] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:52:0)
[03:28:40.883] Timer tick, asking Buildbucket for the build status
[03:28:41.101] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:41.101] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:53:0) after 1m0s
[03:29:41.176] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:53:0)
[03:29:41.176] Timer tick, asking Buildbucket for the build status
[03:29:41.283] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:41.284] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:54:0) after 1m0s
[03:30:41.259] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:54:0)
[03:30:41.259] Timer tick, asking Buildbucket for the build status
[03:30:41.354] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:41.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:55:0) after 1m0s
[03:31:41.356] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:55:0)
[03:31:41.356] Timer tick, asking Buildbucket for the build status
[03:31:41.398] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:41.398] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:56:0) after 1m0s
[03:32:41.439] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:56:0)
[03:32:41.439] Timer tick, asking Buildbucket for the build status
[03:32:41.497] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:41.497] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:57:0) after 1m0s
[03:33:41.510] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:57:0)
[03:33:41.510] Timer tick, asking Buildbucket for the build status
[03:33:41.606] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:41.607] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:58:0) after 1m0s
[03:34:41.626] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:58:0)
[03:34:41.626] Timer tick, asking Buildbucket for the build status
[03:34:41.778] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:41.778] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:59:0) after 1m0s
[03:35:41.768] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:59:0)
[03:35:41.768] Timer tick, asking Buildbucket for the build status
[03:35:41.846] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:41.846] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:60:0) after 1m0s
[03:36:41.867] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:60:0)
[03:36:41.867] Timer tick, asking Buildbucket for the build status
[03:36:41.952] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:41.952] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:61:0) after 1m0s
[03:37:41.975] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:61:0)
[03:37:41.975] Timer tick, asking Buildbucket for the build status
[03:37:42.084] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:42.084] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:62:0) after 1m0s
[03:38:42.119] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:62:0)
[03:38:42.119] Timer tick, asking Buildbucket for the build status
[03:38:42.170] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:42.170] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:63:0) after 1m0s
[03:39:42.192] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:63:0)
[03:39:42.192] Timer tick, asking Buildbucket for the build status
[03:39:42.255] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:42.255] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:64:0) after 1m0s
[03:40:42.271] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:64:0)
[03:40:42.271] Timer tick, asking Buildbucket for the build status
[03:40:42.342] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:42.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:65:0) after 1m0s
[03:41:42.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:65:0)
[03:41:42.363] Timer tick, asking Buildbucket for the build status
[03:41:42.491] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:42.491] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:66:0) after 1m0s
[03:42:42.493] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:66:0)
[03:42:42.493] Timer tick, asking Buildbucket for the build status
[03:42:42.585] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:42.585] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:67:0) after 1m0s
[03:43:42.648] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:67:0)
[03:43:42.648] Timer tick, asking Buildbucket for the build status
[03:43:42.915] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:42.915] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:68:0) after 1m0s
[03:44:42.905] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:68:0)
[03:44:42.905] Timer tick, asking Buildbucket for the build status
[03:44:43.072] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:43.072] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:69:0) after 1m0s
[03:45:43.057] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:69:0)
[03:45:43.057] Timer tick, asking Buildbucket for the build status
[03:45:43.266] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:43.266] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:70:0) after 1m0s
[03:46:43.289] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:70:0)
[03:46:43.289] Timer tick, asking Buildbucket for the build status
[03:46:43.465] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:43.465] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:71:0) after 1m0s
[03:47:43.447] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:71:0)
[03:47:43.447] Timer tick, asking Buildbucket for the build status
[03:47:43.525] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:43.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:72:0) after 1m0s
[03:48:43.548] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:72:0)
[03:48:43.548] Timer tick, asking Buildbucket for the build status
[03:48:43.596] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:43.596] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:73:0) after 1m0s
[03:49:43.625] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:73:0)
[03:49:43.625] Timer tick, asking Buildbucket for the build status
[03:49:43.667] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:43.667] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:74:0) after 1m0s
[03:50:43.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:74:0)
[03:50:43.695] Timer tick, asking Buildbucket for the build status
[03:50:43.866] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:43.866] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:75:0) after 1m0s
[03:51:43.885] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:75:0)
[03:51:43.885] Timer tick, asking Buildbucket for the build status
[03:51:43.989] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:43.990] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:76:0) after 1m0s
[03:52:43.985] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:76:0)
[03:52:43.985] Timer tick, asking Buildbucket for the build status
[03:52:44.166] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:44.166] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:77:0) after 1m0s
[03:53:44.185] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:77:0)
[03:53:44.185] Timer tick, asking Buildbucket for the build status
[03:53:44.231] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:44.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:78:0) after 1m0s
[03:54:44.290] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:78:0)
[03:54:44.290] Timer tick, asking Buildbucket for the build status
[03:54:44.487] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:44.487] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:79:0) after 1m0s
[03:55:44.523] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:79:0)
[03:55:44.523] Timer tick, asking Buildbucket for the build status
[03:55:44.584] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:44.584] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:80:0) after 1m0s
[03:56:44.605] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:80:0)
[03:56:44.605] Timer tick, asking Buildbucket for the build status
[03:56:44.670] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.670] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:81:0) after 1m0s
[03:57:44.691] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:81:0)
[03:57:44.691] Timer tick, asking Buildbucket for the build status
[03:57:44.776] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:44.776] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:82:0) after 1m0s
[03:58:44.813] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:82:0)
[03:58:44.813] Timer tick, asking Buildbucket for the build status
[03:58:44.872] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:44.872] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:83:0) after 1m0s
[03:59:44.898] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:83:0)
[03:59:44.898] Timer tick, asking Buildbucket for the build status
[03:59:45.078] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:45.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:84:0) after 1m0s
[04:00:45.090] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:84:0)
[04:00:45.090] Timer tick, asking Buildbucket for the build status
[04:00:45.133] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:45.133] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:85:0) after 1m0s
[04:01:45.114] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:85:0)
[04:01:45.114] Timer tick, asking Buildbucket for the build status
[04:01:45.377] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:45.378] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:86:0) after 1m0s
[04:02:45.387] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:86:0)
[04:02:45.387] Timer tick, asking Buildbucket for the build status
[04:02:45.556] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:45.556] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:87:0) after 1m0s
[04:03:45.574] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:87:0)
[04:03:45.574] Timer tick, asking Buildbucket for the build status
[04:03:45.642] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:45.642] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:88:0) after 1m0s
[04:04:45.664] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:88:0)
[04:04:45.664] Timer tick, asking Buildbucket for the build status
[04:04:45.769] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:45.769] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:89:0) after 1m0s
[04:05:45.790] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:89:0)
[04:05:45.790] Timer tick, asking Buildbucket for the build status
[04:05:45.832] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.832] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:90:0) after 1m0s
[04:06:45.853] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:90:0)
[04:06:45.853] Timer tick, asking Buildbucket for the build status
[04:06:45.904] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:45.904] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:91:0) after 1m0s
[04:07:45.901] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:91:0)
[04:07:45.901] Timer tick, asking Buildbucket for the build status
[04:07:46.105] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:46.105] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:92:0) after 1m0s
[04:08:46.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:92:0)
[04:08:46.084] Timer tick, asking Buildbucket for the build status
[04:08:46.128] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:46.128] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:93:0) after 1m0s
[04:09:46.161] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:93:0)
[04:09:46.161] Timer tick, asking Buildbucket for the build status
[04:09:46.231] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:46.231] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:94:0) after 1m0s
[04:10:46.237] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:94:0)
[04:10:46.237] Timer tick, asking Buildbucket for the build status
[04:10:46.348] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:46.348] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:95:0) after 1m0s
[04:11:46.370] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:95:0)
[04:11:46.370] Timer tick, asking Buildbucket for the build status
[04:11:46.447] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:46.447] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:96:0) after 1m0s
[04:12:46.451] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:96:0)
[04:12:46.451] Timer tick, asking Buildbucket for the build status
[04:12:46.498] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:46.498] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:97:0) after 1m0s
[04:13:46.507] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:97:0)
[04:13:46.507] Timer tick, asking Buildbucket for the build status
[04:13:46.699] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:46.699] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:98:0) after 1m0s
[04:14:46.702] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:98:0)
[04:14:46.702] Timer tick, asking Buildbucket for the build status
[04:14:46.905] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:46.905] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:99:0) after 1m0s
[04:15:46.924] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:99:0)
[04:15:46.924] Timer tick, asking Buildbucket for the build status
[04:15:47.013] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:47.013] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:100:0) after 1m0s
[04:16:47.019] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:100:0)
[04:16:47.019] Timer tick, asking Buildbucket for the build status
[04:16:47.079] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:47.079] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:101:0) after 1m0s
[04:17:47.122] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:101:0)
[04:17:47.122] Timer tick, asking Buildbucket for the build status
[04:17:47.359] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:47.359] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:102:0) after 1m0s
[04:18:47.329] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:102:0)
[04:18:47.329] Timer tick, asking Buildbucket for the build status
[04:18:47.377] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:47.377] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:103:0) after 1m0s
[04:19:47.399] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:103:0)
[04:19:47.399] Timer tick, asking Buildbucket for the build status
[04:19:47.475] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:47.475] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:104:0) after 1m0s
[04:20:47.499] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:104:0)
[04:20:47.499] Timer tick, asking Buildbucket for the build status
[04:20:47.543] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:47.544] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:105:0) after 1m0s
[04:21:47.579] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:105:0)
[04:21:47.579] Timer tick, asking Buildbucket for the build status
[04:21:47.619] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:47.619] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:106:0) after 1m0s
[04:22:47.596] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:106:0)
[04:22:47.596] Timer tick, asking Buildbucket for the build status
[04:22:47.673] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:47.673] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:107:0) after 1m0s
[04:23:47.695] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:107:0)
[04:23:47.695] Timer tick, asking Buildbucket for the build status
[04:23:47.801] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:47.801] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:108:0) after 1m0s
[04:24:47.824] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:108:0)
[04:24:47.824] Timer tick, asking Buildbucket for the build status
[04:24:47.865] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:47.865] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:109:0) after 1m0s
[04:25:47.891] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:109:0)
[04:25:47.891] Timer tick, asking Buildbucket for the build status
[04:25:47.939] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:47.939] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:110:0) after 1m0s
[04:26:47.939] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:110:0)
[04:26:47.939] Timer tick, asking Buildbucket for the build status
[04:26:47.997] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:47.997] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:111:0) after 1m0s
[04:27:47.970] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:111:0)
[04:27:47.970] Timer tick, asking Buildbucket for the build status
[04:27:48.009] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:48.009] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:112:0) after 1m0s
[04:28:47.986] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:112:0)
[04:28:47.986] Timer tick, asking Buildbucket for the build status
[04:28:48.078] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:48.078] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:113:0) after 1m0s
[04:29:48.084] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:113:0)
[04:29:48.084] Timer tick, asking Buildbucket for the build status
[04:29:48.190] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:48.190] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:114:0) after 1m0s
[04:30:48.211] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:114:0)
[04:30:48.211] Timer tick, asking Buildbucket for the build status
[04:30:48.287] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:48.287] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:115:0) after 1m0s
[04:31:48.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:115:0)
[04:31:48.306] Timer tick, asking Buildbucket for the build status
[04:31:49.984] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:49.984] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:116:0) after 1m0s
[04:32:50.030] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:116:0)
[04:32:50.030] Timer tick, asking Buildbucket for the build status
[04:32:50.196] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:50.196] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:117:0) after 1m0s
[04:33:50.216] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:117:0)
[04:33:50.216] Timer tick, asking Buildbucket for the build status
[04:33:50.300] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:50.300] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:118:0) after 1m0s
[04:34:50.306] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:118:0)
[04:34:50.306] Timer tick, asking Buildbucket for the build status
[04:34:50.354] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:50.354] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:119:0) after 1m0s
[04:35:50.376] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:119:0)
[04:35:50.376] Timer tick, asking Buildbucket for the build status
[04:35:50.687] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:50.687] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:120:0) after 1m0s
[04:36:50.700] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:120:0)
[04:36:50.700] Timer tick, asking Buildbucket for the build status
[04:36:50.803] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:50.803] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:121:0) after 1m0s
[04:37:50.832] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:121:0)
[04:37:50.832] Timer tick, asking Buildbucket for the build status
[04:37:50.975] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:50.975] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:122:0) after 1m0s
[04:38:50.999] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:122:0)
[04:38:50.999] Timer tick, asking Buildbucket for the build status
[04:38:51.055] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:51.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:123:0) after 1m0s
[04:39:51.079] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:123:0)
[04:39:51.079] Timer tick, asking Buildbucket for the build status
[04:39:51.119] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:51.119] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:124:0) after 1m0s
[04:40:51.131] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:124:0)
[04:40:51.132] Timer tick, asking Buildbucket for the build status
[04:40:51.259] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:51.259] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:125:0) after 1m0s
[04:41:51.272] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:125:0)
[04:41:51.272] Timer tick, asking Buildbucket for the build status
[04:41:51.307] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:51.307] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:126:0) after 1m0s
[04:42:51.287] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:126:0)
[04:42:51.287] Timer tick, asking Buildbucket for the build status
[04:42:51.342] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:51.342] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:127:0) after 1m0s
[04:43:51.363] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:127:0)
[04:43:51.363] Timer tick, asking Buildbucket for the build status
[04:43:51.413] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:51.413] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:128:0) after 1m0s
[04:44:51.434] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:128:0)
[04:44:51.434] Timer tick, asking Buildbucket for the build status
[04:44:51.478] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:51.478] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:129:0) after 1m0s
[04:45:51.483] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:129:0)
[04:45:51.483] Timer tick, asking Buildbucket for the build status
[04:45:51.525] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:51.525] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:130:0) after 1m0s
[04:46:51.522] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:130:0)
[04:46:51.522] Timer tick, asking Buildbucket for the build status
[04:46:51.573] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:51.573] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:131:0) after 1m0s
[04:47:51.635] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:131:0)
[04:47:51.635] Timer tick, asking Buildbucket for the build status
[04:47:52.448] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:52.448] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:132:0) after 1m0s
[04:48:52.464] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:132:0)
[04:48:52.464] Timer tick, asking Buildbucket for the build status
[04:48:52.531] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:52.531] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:133:0) after 1m0s
[04:49:52.555] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:133:0)
[04:49:52.555] Timer tick, asking Buildbucket for the build status
[04:49:52.623] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:52.623] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:134:0) after 1m0s
[04:50:52.645] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:134:0)
[04:50:52.645] Timer tick, asking Buildbucket for the build status
[04:50:52.692] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:52.692] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:135:0) after 1m0s
[04:51:52.715] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:135:0)
[04:51:52.715] Timer tick, asking Buildbucket for the build status
[04:51:52.757] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:52.757] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:136:0) after 1m0s
[04:52:52.739] Handling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:136:0)
[04:52:52.739] Timer tick, asking Buildbucket for the build status
[04:52:53.055] Build 8919590432973503824: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:53.055] Scheduling timer "check-buildbucket-build-status" (infra/Build From Tarball:9085020495003298432:137:0) after 1m0s
[04:52:57.517] Received PubSub notification, asking Buildbucket for the build status
[04:52:57.598] Build 8919590432973503824: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:52:57.598] Buildbucket build:
{
"build": {
"bucket": "luci.infra.cron",
"canary_preference": "AUTO",
"completed_ts": "1552020776447022",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1552012713418801",
"id": "8919590432973503824",
"parameters_json": "{\"builder_name\": \"Build From Tarball\", \"properties\": {\"version\": \"74.0.3728.0\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"builder\": [\"Build From Tarball\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"4158-1053c58\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"gpu\": [\"none\"], \"cores\": [\"32\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"gce-trusty-32-0258d129-us-east1-b-sdx5\"], \"pool\": [\"luci.infra.cron\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildername\": \"Build From Tarball\", \"recipe\": \"build_from_tarball\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"version\": \"74.0.3728.0\", \"path_config\": \"generic\", \"bot_id\": \"gce-trusty-32-0258d129-us-east1-b-sdx5\"}}",
"service_account": "chromium-tarball-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1552012770978500",
"status": "COMPLETED",
"status_changed_ts": "1552020777189160",
"tags": [
"builder:Build From Tarball",
"parent_buildername:publish_tarball",
"scheduler_invocation_id:9085020495003298432",
"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/8919590432973503824/+/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:4373fc2876d4b910",
"user_agent:luci-scheduler",
"user_agent:recipe"
],
"updated_ts": "1552020777190413",
"url": "https://ci.chromium.org/b/8919590432973503824",
"utcnow_ts": "1552020777585772"
}
}
[04:52:57.598] Invocation finished in 2h14m25.4996122s with status SUCCEEDED