[12:28:55.503] New invocation is queued and will start shortly
[12:28:56.621] Starting the invocation (attempt 1)
[12:28:56.659] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:28:56.659] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:28:56.659] Buildbucket request:
{
"bucket": "luci.r8.ci",
"client_operation_id": "9085073947855922160",
"parameters_json": "{\"builder_name\":\"archive\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://r8.googlesource.com/r8\",\"revision\":\"5f0e9846f621b0193b0cddb6d8d3feccc1818dc9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:archive",
"scheduler_invocation_id:9085073947855922160",
"scheduler_job_id:r8/archive",
"user_agent:luci-scheduler",
"buildset:commit/git/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"gitiles_ref:refs/heads/master"
]
}
[12:28:58.053] Buildbucket response:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551961736758205",
"id": "8919643885875727200",
"lease_expiration_ts": "1552071537444158",
"lease_key": "1023036009",
"parameters_json": "{\"builder_name\": \"archive\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"5f0e9846f621b0193b0cddb6d8d3feccc1818dc9\"}}",
"project": "r8",
"result_details_json": "{\"properties\": {}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1551961737664138",
"tags": [
"build_address:luci.r8.ci/archive/72",
"builder:archive",
"buildset:commit/git/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085073947855922160",
"scheduler_job_id:r8/archive",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8919643885875727200/+/annotations",
"swarming_tag:luci_project:r8",
"swarming_tag:recipe_name:rex",
"swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
"swarming_task_id:4370f24ff1465710",
"user_agent:luci-scheduler"
],
"updated_ts": "1551961737664260",
"url": "https://ci.chromium.org/b/8919643885875727200",
"utcnow_ts": "1551961737991370"
}
}
[12:28:58.053] Task URL: https://ci.chromium.org/b/8919643885875727200
[12:28:58.053] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:2:0) after 1m0s
[12:29:58.078] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:2:0)
[12:29:58.078] Timer tick, asking Buildbucket for the build status
[12:29:58.269] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:29:58.269] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:3:0) after 1m0s
[12:30:58.288] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:3:0)
[12:30:58.288] Timer tick, asking Buildbucket for the build status
[12:30:58.361] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:30:58.361] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:4:0) after 1m0s
[12:31:58.381] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:4:0)
[12:31:58.381] Timer tick, asking Buildbucket for the build status
[12:31:58.484] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:31:58.484] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:5:0) after 1m0s
[12:32:58.491] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:5:0)
[12:32:58.491] Timer tick, asking Buildbucket for the build status
[12:32:58.674] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:32:58.674] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:6:0) after 1m0s
[12:33:58.692] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:6:0)
[12:33:58.692] Timer tick, asking Buildbucket for the build status
[12:33:58.777] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:33:58.777] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:7:0) after 1m0s
[12:34:58.783] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:7:0)
[12:34:58.783] Timer tick, asking Buildbucket for the build status
[12:34:58.846] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:34:58.846] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:8:0) after 1m0s
[12:35:58.832] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:8:0)
[12:35:58.832] Timer tick, asking Buildbucket for the build status
[12:35:58.896] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:35:58.896] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:9:0) after 1m0s
[12:36:58.912] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:9:0)
[12:36:58.912] Timer tick, asking Buildbucket for the build status
[12:36:59.005] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:36:59.005] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:10:0) after 1m0s
[12:37:59.034] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:10:0)
[12:37:59.034] Timer tick, asking Buildbucket for the build status
[12:37:59.119] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:37:59.119] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:11:0) after 1m0s
[12:38:59.107] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:11:0)
[12:38:59.107] Timer tick, asking Buildbucket for the build status
[12:38:59.156] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:38:59.156] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:12:0) after 1m0s
[12:39:59.203] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:12:0)
[12:39:59.203] Timer tick, asking Buildbucket for the build status
[12:39:59.278] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:39:59.278] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:13:0) after 1m0s
[12:40:59.259] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:13:0)
[12:40:59.259] Timer tick, asking Buildbucket for the build status
[12:40:59.311] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:40:59.311] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:14:0) after 1m0s
[12:41:59.318] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:14:0)
[12:41:59.318] Timer tick, asking Buildbucket for the build status
[12:41:59.386] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:41:59.386] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:15:0) after 1m0s
[12:42:59.381] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:15:0)
[12:42:59.381] Timer tick, asking Buildbucket for the build status
[12:42:59.479] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:42:59.479] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:16:0) after 1m0s
[12:43:59.503] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:16:0)
[12:43:59.503] Timer tick, asking Buildbucket for the build status
[12:43:59.611] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:43:59.611] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:17:0) after 1m0s
[12:44:59.601] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:17:0)
[12:44:59.601] Timer tick, asking Buildbucket for the build status
[12:44:59.755] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:44:59.755] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:18:0) after 1m0s
[12:45:59.779] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:18:0)
[12:45:59.779] Timer tick, asking Buildbucket for the build status
[12:46:00.088] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:46:00.088] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:19:0) after 1m0s
[12:47:00.154] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:19:0)
[12:47:00.154] Timer tick, asking Buildbucket for the build status
[12:47:00.281] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:47:00.281] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:20:0) after 1m0s
[12:48:00.262] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:20:0)
[12:48:00.262] Timer tick, asking Buildbucket for the build status
[12:48:00.401] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:48:00.401] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:21:0) after 1m0s
[12:49:00.402] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:21:0)
[12:49:00.402] Timer tick, asking Buildbucket for the build status
[12:49:00.464] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:49:00.464] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:22:0) after 1m0s
[12:50:00.477] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:22:0)
[12:50:00.477] Timer tick, asking Buildbucket for the build status
[12:50:00.570] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:50:00.570] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:23:0) after 1m0s
[12:51:00.563] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:23:0)
[12:51:00.563] Timer tick, asking Buildbucket for the build status
[12:51:00.621] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:51:00.621] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:24:0) after 1m0s
[12:52:00.628] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:24:0)
[12:52:00.628] Timer tick, asking Buildbucket for the build status
[12:52:00.750] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:52:00.750] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:25:0) after 1m0s
[12:53:00.796] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:25:0)
[12:53:00.796] Timer tick, asking Buildbucket for the build status
[12:53:00.843] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:53:00.843] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:26:0) after 1m0s
[12:54:00.857] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:26:0)
[12:54:00.857] Timer tick, asking Buildbucket for the build status
[12:54:01.009] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:54:01.009] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:27:0) after 1m0s
[12:55:01.013] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:27:0)
[12:55:01.013] Timer tick, asking Buildbucket for the build status
[12:55:01.162] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:55:01.162] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:28:0) after 1m0s
[12:56:01.186] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:28:0)
[12:56:01.186] Timer tick, asking Buildbucket for the build status
[12:56:01.276] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:56:01.276] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:29:0) after 1m0s
[12:57:01.259] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:29:0)
[12:57:01.259] Timer tick, asking Buildbucket for the build status
[12:57:01.387] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:57:01.387] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:30:0) after 1m0s
[12:58:01.417] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:30:0)
[12:58:01.417] Timer tick, asking Buildbucket for the build status
[12:58:01.507] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:58:01.507] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:31:0) after 1m0s
[12:59:01.524] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:31:0)
[12:59:01.524] Timer tick, asking Buildbucket for the build status
[12:59:01.762] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:59:01.763] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:32:0) after 1m0s
[13:00:01.775] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:32:0)
[13:00:01.775] Timer tick, asking Buildbucket for the build status
[13:00:01.853] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:00:01.853] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:33:0) after 1m0s
[13:01:01.895] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:33:0)
[13:01:01.895] Timer tick, asking Buildbucket for the build status
[13:01:01.971] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:01:01.971] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:34:0) after 1m0s
[13:02:02.003] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:34:0)
[13:02:02.003] Timer tick, asking Buildbucket for the build status
[13:02:02.089] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:02:02.089] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:35:0) after 1m0s
[13:03:02.106] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:35:0)
[13:03:02.106] Timer tick, asking Buildbucket for the build status
[13:03:02.280] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:03:02.280] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:36:0) after 1m0s
[13:04:02.285] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:36:0)
[13:04:02.285] Timer tick, asking Buildbucket for the build status
[13:04:02.395] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:04:02.395] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:37:0) after 1m0s
[13:05:02.375] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:37:0)
[13:05:02.375] Timer tick, asking Buildbucket for the build status
[13:05:02.435] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:05:02.435] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:38:0) after 1m0s
[13:06:02.460] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:38:0)
[13:06:02.460] Timer tick, asking Buildbucket for the build status
[13:06:02.533] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:06:02.533] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:39:0) after 1m0s
[13:07:02.553] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:39:0)
[13:07:02.553] Timer tick, asking Buildbucket for the build status
[13:07:02.672] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:07:02.672] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:40:0) after 1m0s
[13:08:02.691] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:40:0)
[13:08:02.691] Timer tick, asking Buildbucket for the build status
[13:08:02.768] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:08:02.768] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:41:0) after 1m0s
[13:09:02.751] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:41:0)
[13:09:02.751] Timer tick, asking Buildbucket for the build status
[13:09:02.839] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:09:02.839] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:42:0) after 1m0s
[13:10:02.853] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:42:0)
[13:10:02.853] Timer tick, asking Buildbucket for the build status
[13:10:02.924] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:10:02.924] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:43:0) after 1m0s
[13:11:02.916] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:43:0)
[13:11:02.916] Timer tick, asking Buildbucket for the build status
[13:11:02.967] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:11:02.967] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:44:0) after 1m0s
[13:12:02.941] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:44:0)
[13:12:02.941] Timer tick, asking Buildbucket for the build status
[13:12:03.079] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:12:03.079] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:45:0) after 1m0s
[13:13:03.122] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:45:0)
[13:13:03.122] Timer tick, asking Buildbucket for the build status
[13:13:03.177] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:13:03.177] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:46:0) after 1m0s
[13:14:03.197] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:46:0)
[13:14:03.197] Timer tick, asking Buildbucket for the build status
[13:14:03.261] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:14:03.261] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:47:0) after 1m0s
[13:15:03.282] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:47:0)
[13:15:03.282] Timer tick, asking Buildbucket for the build status
[13:15:03.339] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:15:03.339] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:48:0) after 1m0s
[13:16:03.357] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:48:0)
[13:16:03.357] Timer tick, asking Buildbucket for the build status
[13:16:03.427] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:16:03.427] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:49:0) after 1m0s
[13:17:03.428] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:49:0)
[13:17:03.428] Timer tick, asking Buildbucket for the build status
[13:17:03.557] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:17:03.557] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:50:0) after 1m0s
[13:18:03.532] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:50:0)
[13:18:03.532] Timer tick, asking Buildbucket for the build status
[13:18:03.619] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:18:03.619] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:51:0) after 1m0s
[13:19:03.610] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:51:0)
[13:19:03.610] Timer tick, asking Buildbucket for the build status
[13:19:03.923] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:19:03.923] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:52:0) after 1m0s
[13:20:03.947] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:52:0)
[13:20:03.947] Timer tick, asking Buildbucket for the build status
[13:20:04.203] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:20:04.203] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:53:0) after 1m0s
[13:21:04.202] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:53:0)
[13:21:04.202] Timer tick, asking Buildbucket for the build status
[13:21:04.251] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:21:04.251] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:54:0) after 1m0s
[13:22:04.275] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:54:0)
[13:22:04.275] Timer tick, asking Buildbucket for the build status
[13:22:04.415] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:22:04.415] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:55:0) after 1m0s
[13:23:04.409] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:55:0)
[13:23:04.409] Timer tick, asking Buildbucket for the build status
[13:23:04.462] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:23:04.462] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:56:0) after 1m0s
[13:24:04.485] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:56:0)
[13:24:04.485] Timer tick, asking Buildbucket for the build status
[13:24:04.558] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:24:04.558] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:57:0) after 1m0s
[13:25:04.544] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:57:0)
[13:25:04.544] Timer tick, asking Buildbucket for the build status
[13:25:04.627] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:25:04.627] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:58:0) after 1m0s
[13:26:04.649] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:58:0)
[13:26:04.649] Timer tick, asking Buildbucket for the build status
[13:26:04.717] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:26:04.717] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:59:0) after 1m0s
[13:27:04.712] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:59:0)
[13:27:04.712] Timer tick, asking Buildbucket for the build status
[13:27:04.789] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:27:04.789] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:60:0) after 1m0s
[13:28:04.781] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:60:0)
[13:28:04.781] Timer tick, asking Buildbucket for the build status
[13:28:04.832] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:28:04.832] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:61:0) after 1m0s
[13:29:04.828] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:61:0)
[13:29:04.828] Timer tick, asking Buildbucket for the build status
[13:29:05.014] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:29:05.014] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:62:0) after 1m0s
[13:30:05.037] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:62:0)
[13:30:05.037] Timer tick, asking Buildbucket for the build status
[13:30:05.094] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:30:05.094] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:63:0) after 1m0s
[13:31:05.174] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:63:0)
[13:31:05.174] Timer tick, asking Buildbucket for the build status
[13:31:05.325] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:31:05.325] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:64:0) after 1m0s
[13:32:05.334] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:64:0)
[13:32:05.334] Timer tick, asking Buildbucket for the build status
[13:32:05.395] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:32:05.395] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:65:0) after 1m0s
[13:33:05.394] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:65:0)
[13:33:05.394] Timer tick, asking Buildbucket for the build status
[13:33:05.477] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:33:05.477] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:66:0) after 1m0s
[13:34:05.475] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:66:0)
[13:34:05.475] Timer tick, asking Buildbucket for the build status
[13:34:05.577] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:34:05.577] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:67:0) after 1m0s
[13:35:05.626] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:67:0)
[13:35:05.626] Timer tick, asking Buildbucket for the build status
[13:35:05.700] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:35:05.700] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:68:0) after 1m0s
[13:36:05.757] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:68:0)
[13:36:05.757] Timer tick, asking Buildbucket for the build status
[13:36:05.915] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:36:05.915] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:69:0) after 1m0s
[13:37:05.940] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:69:0)
[13:37:05.940] Timer tick, asking Buildbucket for the build status
[13:37:06.002] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:37:06.002] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:70:0) after 1m0s
[13:38:06.013] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:70:0)
[13:38:06.013] Timer tick, asking Buildbucket for the build status
[13:38:06.465] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:38:06.465] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:71:0) after 1m0s
[13:39:06.509] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:71:0)
[13:39:06.509] Timer tick, asking Buildbucket for the build status
[13:39:06.562] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:39:06.562] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:72:0) after 1m0s
[13:40:06.630] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:72:0)
[13:40:06.630] Timer tick, asking Buildbucket for the build status
[13:40:06.774] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:40:06.774] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:73:0) after 1m0s
[13:41:06.770] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:73:0)
[13:41:06.770] Timer tick, asking Buildbucket for the build status
[13:41:06.894] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:41:06.894] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:74:0) after 1m0s
[13:42:06.916] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:74:0)
[13:42:06.916] Timer tick, asking Buildbucket for the build status
[13:42:07.189] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:42:07.189] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:75:0) after 1m0s
[13:43:07.214] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:75:0)
[13:43:07.214] Timer tick, asking Buildbucket for the build status
[13:43:07.294] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:43:07.294] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:76:0) after 1m0s
[13:44:07.305] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:76:0)
[13:44:07.305] Timer tick, asking Buildbucket for the build status
[13:44:07.363] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:44:07.363] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:77:0) after 1m0s
[13:45:07.376] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:77:0)
[13:45:07.376] Timer tick, asking Buildbucket for the build status
[13:45:07.450] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:45:07.450] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:78:0) after 1m0s
[13:46:07.470] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:78:0)
[13:46:07.470] Timer tick, asking Buildbucket for the build status
[13:46:07.542] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:46:07.542] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:79:0) after 1m0s
[13:47:07.564] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:79:0)
[13:47:07.564] Timer tick, asking Buildbucket for the build status
[13:47:07.914] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:47:07.914] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:80:0) after 1m0s
[13:48:07.934] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:80:0)
[13:48:07.934] Timer tick, asking Buildbucket for the build status
[13:48:07.983] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:48:07.983] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:81:0) after 1m0s
[13:49:08.001] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:81:0)
[13:49:08.001] Timer tick, asking Buildbucket for the build status
[13:49:08.119] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:49:08.119] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:82:0) after 1m0s
[13:50:08.141] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:82:0)
[13:50:08.141] Timer tick, asking Buildbucket for the build status
[13:50:08.235] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:50:08.235] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:83:0) after 1m0s
[13:51:08.236] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:83:0)
[13:51:08.236] Timer tick, asking Buildbucket for the build status
[13:51:08.314] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:51:08.314] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:84:0) after 1m0s
[13:52:08.292] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:84:0)
[13:52:08.292] Timer tick, asking Buildbucket for the build status
[13:52:08.388] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:52:08.388] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:85:0) after 1m0s
[13:53:08.411] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:85:0)
[13:53:08.411] Timer tick, asking Buildbucket for the build status
[13:53:08.606] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:53:08.606] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:86:0) after 1m0s
[13:54:08.610] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:86:0)
[13:54:08.610] Timer tick, asking Buildbucket for the build status
[13:54:08.789] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:54:08.789] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:87:0) after 1m0s
[13:55:08.829] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:87:0)
[13:55:08.829] Timer tick, asking Buildbucket for the build status
[13:55:08.889] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:55:08.889] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:88:0) after 1m0s
[13:56:08.884] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:88:0)
[13:56:08.884] Timer tick, asking Buildbucket for the build status
[13:56:08.993] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:56:08.993] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:89:0) after 1m0s
[13:57:09.002] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:89:0)
[13:57:09.002] Timer tick, asking Buildbucket for the build status
[13:57:09.071] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:57:09.071] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:90:0) after 1m0s
[13:58:09.058] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:90:0)
[13:58:09.058] Timer tick, asking Buildbucket for the build status
[13:58:09.134] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:58:09.134] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:91:0) after 1m0s
[13:59:09.128] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:91:0)
[13:59:09.128] Timer tick, asking Buildbucket for the build status
[13:59:09.238] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[13:59:09.238] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:92:0) after 1m0s
[14:00:09.264] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:92:0)
[14:00:09.264] Timer tick, asking Buildbucket for the build status
[14:00:09.352] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:00:09.352] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:93:0) after 1m0s
[14:01:09.634] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:93:0)
[14:01:09.634] Timer tick, asking Buildbucket for the build status
[14:01:09.714] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:01:09.714] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:94:0) after 1m0s
[14:02:09.704] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:94:0)
[14:02:09.704] Timer tick, asking Buildbucket for the build status
[14:02:09.840] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:02:09.840] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:95:0) after 1m0s
[14:03:09.834] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:95:0)
[14:03:09.834] Timer tick, asking Buildbucket for the build status
[14:03:09.928] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:03:09.928] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:96:0) after 1m0s
[14:04:09.958] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:96:0)
[14:04:09.958] Timer tick, asking Buildbucket for the build status
[14:04:10.031] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:04:10.031] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:97:0) after 1m0s
[14:05:10.046] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:97:0)
[14:05:10.046] Timer tick, asking Buildbucket for the build status
[14:05:10.188] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:05:10.188] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:98:0) after 1m0s
[14:06:10.171] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:98:0)
[14:06:10.172] Timer tick, asking Buildbucket for the build status
[14:06:10.241] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:06:10.241] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:99:0) after 1m0s
[14:07:10.250] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:99:0)
[14:07:10.250] Timer tick, asking Buildbucket for the build status
[14:07:10.373] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:07:10.373] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:100:0) after 1m0s
[14:08:10.397] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:100:0)
[14:08:10.397] Timer tick, asking Buildbucket for the build status
[14:08:10.489] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:08:10.489] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:101:0) after 1m0s
[14:09:10.468] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:101:0)
[14:09:10.468] Timer tick, asking Buildbucket for the build status
[14:09:10.594] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:09:10.594] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:102:0) after 1m0s
[14:10:10.614] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:102:0)
[14:10:10.614] Timer tick, asking Buildbucket for the build status
[14:10:10.672] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:10:10.672] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:103:0) after 1m0s
[14:11:10.701] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:103:0)
[14:11:10.701] Timer tick, asking Buildbucket for the build status
[14:11:10.873] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:11:10.873] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:104:0) after 1m0s
[14:12:10.896] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:104:0)
[14:12:10.896] Timer tick, asking Buildbucket for the build status
[14:12:10.969] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:12:10.970] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:105:0) after 1m0s
[14:13:10.938] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:105:0)
[14:13:10.938] Timer tick, asking Buildbucket for the build status
[14:13:10.989] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:13:10.989] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:106:0) after 1m0s
[14:14:10.980] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:106:0)
[14:14:10.980] Timer tick, asking Buildbucket for the build status
[14:14:11.034] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:14:11.034] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:107:0) after 1m0s
[14:15:11.035] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:107:0)
[14:15:11.035] Timer tick, asking Buildbucket for the build status
[14:15:11.103] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:15:11.103] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:108:0) after 1m0s
[14:16:11.105] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:108:0)
[14:16:11.105] Timer tick, asking Buildbucket for the build status
[14:16:11.164] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:16:11.164] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:109:0) after 1m0s
[14:17:11.186] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:109:0)
[14:17:11.186] Timer tick, asking Buildbucket for the build status
[14:17:11.240] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:17:11.240] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:110:0) after 1m0s
[14:18:11.265] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:110:0)
[14:18:11.265] Timer tick, asking Buildbucket for the build status
[14:18:11.362] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:18:11.362] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:111:0) after 1m0s
[14:19:11.388] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:111:0)
[14:19:11.388] Timer tick, asking Buildbucket for the build status
[14:19:11.509] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:19:11.509] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:112:0) after 1m0s
[14:20:11.531] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:112:0)
[14:20:11.531] Timer tick, asking Buildbucket for the build status
[14:20:11.578] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:20:11.578] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:113:0) after 1m0s
[14:21:11.599] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:113:0)
[14:21:11.599] Timer tick, asking Buildbucket for the build status
[14:21:11.693] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:21:11.693] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:114:0) after 1m0s
[14:22:11.683] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:114:0)
[14:22:11.683] Timer tick, asking Buildbucket for the build status
[14:22:11.807] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:22:11.807] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:115:0) after 1m0s
[14:23:11.829] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:115:0)
[14:23:11.829] Timer tick, asking Buildbucket for the build status
[14:23:11.896] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:23:11.896] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:116:0) after 1m0s
[14:24:11.892] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:116:0)
[14:24:11.892] Timer tick, asking Buildbucket for the build status
[14:24:11.943] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:24:11.943] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:117:0) after 1m0s
[14:25:12.019] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:117:0)
[14:25:12.019] Timer tick, asking Buildbucket for the build status
[14:25:12.086] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:25:12.086] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:118:0) after 1m0s
[14:26:12.132] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:118:0)
[14:26:12.132] Timer tick, asking Buildbucket for the build status
[14:26:12.301] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:26:12.301] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:119:0) after 1m0s
[14:27:12.352] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:119:0)
[14:27:12.352] Timer tick, asking Buildbucket for the build status
[14:27:12.479] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:27:12.479] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:120:0) after 1m0s
[14:28:12.504] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:120:0)
[14:28:12.504] Timer tick, asking Buildbucket for the build status
[14:28:12.620] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:28:12.620] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:121:0) after 1m0s
[14:29:12.624] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:121:0)
[14:29:12.624] Timer tick, asking Buildbucket for the build status
[14:29:12.762] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:29:12.763] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:122:0) after 1m0s
[14:30:12.787] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:122:0)
[14:30:12.787] Timer tick, asking Buildbucket for the build status
[14:30:12.840] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:30:12.840] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:123:0) after 1m0s
[14:31:12.861] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:123:0)
[14:31:12.861] Timer tick, asking Buildbucket for the build status
[14:31:12.931] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:31:12.931] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:124:0) after 1m0s
[14:32:12.976] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:124:0)
[14:32:12.976] Timer tick, asking Buildbucket for the build status
[14:32:13.028] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:32:13.028] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:125:0) after 1m0s
[14:33:13.007] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:125:0)
[14:33:13.007] Timer tick, asking Buildbucket for the build status
[14:33:13.057] Build 8919643885875727200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:33:13.057] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:126:0) after 1m0s
[14:33:25.236] Received PubSub notification, asking Buildbucket for the build status
[14:33:25.442] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:13.089] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:126:0)
[14:34:13.089] Timer tick, asking Buildbucket for the build status
[14:34:13.228] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:13.228] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:128:0) after 1m0s
[14:35:13.250] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:128:0)
[14:35:13.250] Timer tick, asking Buildbucket for the build status
[14:35:13.285] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:13.285] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:129:0) after 1m0s
[14:36:13.274] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:129:0)
[14:36:13.274] Timer tick, asking Buildbucket for the build status
[14:36:13.341] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:13.341] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:130:0) after 1m0s
[14:37:13.363] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:130:0)
[14:37:13.363] Timer tick, asking Buildbucket for the build status
[14:37:13.401] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:13.401] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:131:0) after 1m0s
[14:38:13.396] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:131:0)
[14:38:13.396] Timer tick, asking Buildbucket for the build status
[14:38:13.550] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:13.550] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:132:0) after 1m0s
[14:39:13.576] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:132:0)
[14:39:13.576] Timer tick, asking Buildbucket for the build status
[14:39:13.770] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:13.770] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:133:0) after 1m0s
[14:40:13.790] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:133:0)
[14:40:13.790] Timer tick, asking Buildbucket for the build status
[14:40:13.870] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:13.870] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:134:0) after 1m0s
[14:41:13.857] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:134:0)
[14:41:13.857] Timer tick, asking Buildbucket for the build status
[14:41:13.913] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:13.913] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:135:0) after 1m0s
[14:42:13.934] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:135:0)
[14:42:13.934] Timer tick, asking Buildbucket for the build status
[14:42:13.984] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:13.984] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:136:0) after 1m0s
[14:43:13.983] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:136:0)
[14:43:13.983] Timer tick, asking Buildbucket for the build status
[14:43:14.062] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:14.062] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:137:0) after 1m0s
[14:44:14.063] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:137:0)
[14:44:14.063] Timer tick, asking Buildbucket for the build status
[14:44:14.113] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:14.113] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:138:0) after 1m0s
[14:45:14.139] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:138:0)
[14:45:14.139] Timer tick, asking Buildbucket for the build status
[14:45:14.208] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:14.208] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:139:0) after 1m0s
[14:46:14.181] Handling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:139:0)
[14:46:14.181] Timer tick, asking Buildbucket for the build status
[14:46:14.271] Build 8919643885875727200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:14.271] Scheduling timer "check-buildbucket-build-status" (r8/archive:9085073947855922160:140:0) after 1m0s
[14:46:26.815] Received PubSub notification, asking Buildbucket for the build status
[14:46:26.863] Build 8919643885875727200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:46:26.863] Buildbucket build:
{
"build": {
"bucket": "luci.r8.ci",
"canary_preference": "AUTO",
"completed_ts": "1551969984511220",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1551961736758205",
"id": "8919643885875727200",
"parameters_json": "{\"builder_name\": \"archive\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://r8.googlesource.com/r8\", \"revision\": \"5f0e9846f621b0193b0cddb6d8d3feccc1818dc9\"}}",
"project": "r8",
"result": "SUCCESS",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"gce\": [\"1\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"], \"inside_docker\": [\"0\"], \"locale\": [\"en_US.UTF-8\"], \"image\": [\"chrome-xenial-18041000-0b3ff326a44\"], \"kvm\": [\"0\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4154-750e250\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"id\": [\"gce-xenial-396d8f4b-us-east1-b-86rj\"], \"pool\": [\"luci.r8.ci\"], \"caches\": [\"vpython\"]}}, \"ui\": {\"info\": \"\"}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 72, \"repository\": \"https://r8.googlesource.com/r8\", \"buildername\": \"archive\", \"recipe\": \"rex\", \"mastername\": \"internal.client.r8\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"bot_id\": \"gce-xenial-396d8f4b-us-east1-b-86rj\", \"archive\": \"True\", \"revision\": \"5f0e9846f621b0193b0cddb6d8d3feccc1818dc9\"}}",
"service_account": "r8-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1551969204166753",
"status": "COMPLETED",
"status_changed_ts": "1551969986507800",
"tags": [
"build_address:luci.r8.ci/archive/72",
"builder:archive",
"buildset:commit/git/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"buildset:commit/gitiles/r8.googlesource.com/r8/+/5f0e9846f621b0193b0cddb6d8d3feccc1818dc9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9085073947855922160",
"scheduler_job_id:r8/archive",
"swarming_hostname:chrome-swarming.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/r8/buildbucket/cr-buildbucket.appspot.com/8919643885875727200/+/annotations",
"swarming_tag:luci_project:r8",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:rex",
"swarming_tag:recipe_package:infra_internal/recipe_bundles/chrome-internal.googlesource.com/chrome/tools/build_limited/scripts/slave",
"swarming_task_id:4370f24ff1465710",
"user_agent:luci-scheduler"
],
"updated_ts": "1551969986509606",
"url": "https://ci.chromium.org/b/8919643885875727200",
"utcnow_ts": "1551969986854185"
}
}
[14:46:26.863] Invocation finished in 2h17m31.376953647s with status SUCCEEDED