[20:12:38.410] New invocation is queued and will start shortly
[20:12:39.599] Starting the invocation (attempt 1)
[20:12:39.650] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:12:39.651] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:12:39.651] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050889717087993968",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7f5e20cc372436189fb52808adbaab4fb3a38ebd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9050889717087993968",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"gitiles_ref:refs/heads/master"
]
}
[20:12:44.918] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1584562360177551",
"id": "8885459654573813264",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5e20cc372436189fb52808adbaab4fb3a38ebd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1584562363905695",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27213",
"builder:Deterministic Linux",
"buildset:commit/git/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050889717087993968",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8885459654573813264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1584562363905869",
"url": "https://ci.chromium.org/b/8885459654573813264",
"utcnow_ts": "1584562364878401"
}
}
[20:12:44.918] Task URL: https://ci.chromium.org/b/8885459654573813264
[20:12:44.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:2:0) after 1m0s
[20:13:45.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:2:0)
[20:13:45.013] Timer tick, asking Buildbucket for the build status
[20:13:45.126] Build 8885459654573813264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:45.126] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:3:0) after 1m0s
[20:14:45.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:3:0)
[20:14:45.172] Timer tick, asking Buildbucket for the build status
[20:14:45.324] Build 8885459654573813264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:45.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:4:0) after 1m0s
[20:15:45.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:4:0)
[20:15:45.355] Timer tick, asking Buildbucket for the build status
[20:15:45.472] Build 8885459654573813264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:15:45.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:5:0) after 1m0s
[20:16:45.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:5:0)
[20:16:45.516] Timer tick, asking Buildbucket for the build status
[20:16:47.376] Build 8885459654573813264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:16:47.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:6:0) after 1m0s
[20:17:47.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:6:0)
[20:17:47.382] Timer tick, asking Buildbucket for the build status
[20:17:47.486] Build 8885459654573813264: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:17:47.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:7:0) after 1m0s
[20:18:22.029] Received PubSub notification, asking Buildbucket for the build status
[20:18:22.515] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:47.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:7:0)
[20:18:47.488] Timer tick, asking Buildbucket for the build status
[20:18:47.647] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:47.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:9:0) after 1m0s
[20:19:47.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:9:0)
[20:19:47.718] Timer tick, asking Buildbucket for the build status
[20:19:47.909] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:47.909] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:10:0) after 1m0s
[20:20:47.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:10:0)
[20:20:47.928] Timer tick, asking Buildbucket for the build status
[20:20:48.476] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:48.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:11:0) after 1m0s
[20:21:48.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:11:0)
[20:21:48.496] Timer tick, asking Buildbucket for the build status
[20:21:48.864] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:48.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:12:0) after 1m0s
[20:22:48.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:12:0)
[20:22:48.884] Timer tick, asking Buildbucket for the build status
[20:22:49.095] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:49.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:13:0) after 1m0s
[20:23:49.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:13:0)
[20:23:49.185] Timer tick, asking Buildbucket for the build status
[20:23:49.570] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:49.570] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:14:0) after 1m0s
[20:24:49.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:14:0)
[20:24:49.563] Timer tick, asking Buildbucket for the build status
[20:24:50.289] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:50.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:15:0) after 1m0s
[20:25:50.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:15:0)
[20:25:50.307] Timer tick, asking Buildbucket for the build status
[20:25:50.455] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:50.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:16:0) after 1m0s
[20:26:50.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:16:0)
[20:26:50.508] Timer tick, asking Buildbucket for the build status
[20:26:52.224] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:52.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:17:0) after 1m0s
[20:27:52.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:17:0)
[20:27:52.278] Timer tick, asking Buildbucket for the build status
[20:27:52.654] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:52.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:18:0) after 1m0s
[20:28:52.675] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:18:0)
[20:28:52.675] Timer tick, asking Buildbucket for the build status
[20:28:53.273] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:53.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:19:0) after 1m0s
[20:29:53.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:19:0)
[20:29:53.297] Timer tick, asking Buildbucket for the build status
[20:29:53.414] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:53.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:20:0) after 1m0s
[20:30:53.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:20:0)
[20:30:53.410] Timer tick, asking Buildbucket for the build status
[20:30:53.584] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:53.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:21:0) after 1m0s
[20:31:53.570] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:21:0)
[20:31:53.570] Timer tick, asking Buildbucket for the build status
[20:31:54.013] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:54.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:22:0) after 1m0s
[20:32:54.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:22:0)
[20:32:54.026] Timer tick, asking Buildbucket for the build status
[20:32:54.221] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:54.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:23:0) after 1m0s
[20:33:54.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:23:0)
[20:33:54.284] Timer tick, asking Buildbucket for the build status
[20:33:54.516] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:54.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:24:0) after 1m0s
[20:34:54.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:24:0)
[20:34:54.544] Timer tick, asking Buildbucket for the build status
[20:34:54.743] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:54.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:25:0) after 1m0s
[20:35:54.815] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:25:0)
[20:35:54.815] Timer tick, asking Buildbucket for the build status
[20:35:54.917] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:54.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:26:0) after 1m0s
[20:36:54.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:26:0)
[20:36:54.950] Timer tick, asking Buildbucket for the build status
[20:36:55.240] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:55.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:27:0) after 1m0s
[20:37:55.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:27:0)
[20:37:55.264] Timer tick, asking Buildbucket for the build status
[20:37:55.330] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:55.330] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:28:0) after 1m0s
[20:38:55.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:28:0)
[20:38:55.495] Timer tick, asking Buildbucket for the build status
[20:38:55.781] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:55.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:29:0) after 1m0s
[20:39:55.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:29:0)
[20:39:55.841] Timer tick, asking Buildbucket for the build status
[20:39:56.187] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:56.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:30:0) after 1m0s
[20:40:56.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:30:0)
[20:40:56.272] Timer tick, asking Buildbucket for the build status
[20:40:56.377] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:56.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:31:0) after 1m0s
[20:41:56.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:31:0)
[20:41:56.466] Timer tick, asking Buildbucket for the build status
[20:41:56.553] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:56.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:32:0) after 1m0s
[20:42:56.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:32:0)
[20:42:56.564] Timer tick, asking Buildbucket for the build status
[20:42:56.742] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:56.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:33:0) after 1m0s
[20:43:56.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:33:0)
[20:43:56.780] Timer tick, asking Buildbucket for the build status
[20:43:57.535] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:57.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:34:0) after 1m0s
[20:44:57.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:34:0)
[20:44:57.702] Timer tick, asking Buildbucket for the build status
[20:44:57.786] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:57.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:35:0) after 1m0s
[20:45:57.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:35:0)
[20:45:57.810] Timer tick, asking Buildbucket for the build status
[20:45:58.284] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:58.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:36:0) after 1m0s
[20:46:58.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:36:0)
[20:46:58.318] Timer tick, asking Buildbucket for the build status
[20:46:58.414] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:58.414] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:37:0) after 1m0s
[20:47:58.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:37:0)
[20:47:58.468] Timer tick, asking Buildbucket for the build status
[20:47:58.611] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:58.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:38:0) after 1m0s
[20:48:58.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:38:0)
[20:48:58.944] Timer tick, asking Buildbucket for the build status
[20:48:59.437] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:59.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:39:0) after 1m0s
[20:49:59.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:39:0)
[20:49:59.468] Timer tick, asking Buildbucket for the build status
[20:50:00.571] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:00.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:40:0) after 1m0s
[20:51:01.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:40:0)
[20:51:01.177] Timer tick, asking Buildbucket for the build status
[20:51:01.323] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:01.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:41:0) after 1m0s
[20:52:01.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:41:0)
[20:52:01.476] Timer tick, asking Buildbucket for the build status
[20:52:03.131] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:03.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:42:0) after 1m0s
[20:53:03.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:42:0)
[20:53:03.337] Timer tick, asking Buildbucket for the build status
[20:53:04.006] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:04.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:43:0) after 1m0s
[20:54:04.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:43:0)
[20:54:04.165] Timer tick, asking Buildbucket for the build status
[20:54:04.292] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:04.292] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:44:0) after 1m0s
[20:55:04.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:44:0)
[20:55:04.390] Timer tick, asking Buildbucket for the build status
[20:55:04.647] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:04.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:45:0) after 1m0s
[20:56:04.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:45:0)
[20:56:04.676] Timer tick, asking Buildbucket for the build status
[20:56:07.803] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:07.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:46:0) after 1m0s
[20:57:07.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:46:0)
[20:57:07.843] Timer tick, asking Buildbucket for the build status
[20:57:07.938] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:07.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:47:0) after 1m0s
[20:58:08.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:47:0)
[20:58:08.077] Timer tick, asking Buildbucket for the build status
[20:58:08.373] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:08.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:48:0) after 1m0s
[20:59:08.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:48:0)
[20:59:08.430] Timer tick, asking Buildbucket for the build status
[20:59:08.676] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:08.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:49:0) after 1m0s
[21:00:08.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:49:0)
[21:00:08.913] Timer tick, asking Buildbucket for the build status
[21:00:09.038] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:09.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:50:0) after 1m0s
[21:01:09.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:50:0)
[21:01:09.238] Timer tick, asking Buildbucket for the build status
[21:01:09.612] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:09.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:51:0) after 1m0s
[21:02:09.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:51:0)
[21:02:09.710] Timer tick, asking Buildbucket for the build status
[21:02:10.144] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:10.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:52:0) after 1m0s
[21:03:10.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:52:0)
[21:03:10.195] Timer tick, asking Buildbucket for the build status
[21:03:10.555] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:10.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:53:0) after 1m0s
[21:04:10.567] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:53:0)
[21:04:10.567] Timer tick, asking Buildbucket for the build status
[21:04:11.509] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:11.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:54:0) after 1m0s
[21:05:11.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:54:0)
[21:05:11.516] Timer tick, asking Buildbucket for the build status
[21:05:11.743] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:11.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:55:0) after 1m0s
[21:06:11.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:55:0)
[21:06:11.885] Timer tick, asking Buildbucket for the build status
[21:06:12.103] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:12.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:56:0) after 1m0s
[21:07:12.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:56:0)
[21:07:12.202] Timer tick, asking Buildbucket for the build status
[21:07:13.721] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:13.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:57:0) after 1m0s
[21:08:13.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:57:0)
[21:08:13.745] Timer tick, asking Buildbucket for the build status
[21:08:13.907] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:13.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:58:0) after 1m0s
[21:09:13.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:58:0)
[21:09:13.887] Timer tick, asking Buildbucket for the build status
[21:09:14.145] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:14.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:59:0) after 1m0s
[21:10:14.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:59:0)
[21:10:14.212] Timer tick, asking Buildbucket for the build status
[21:10:14.545] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:14.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:60:0) after 1m0s
[21:11:14.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:60:0)
[21:11:14.695] Timer tick, asking Buildbucket for the build status
[21:11:15.384] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:15.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:61:0) after 1m0s
[21:12:15.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:61:0)
[21:12:15.443] Timer tick, asking Buildbucket for the build status
[21:12:16.551] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:16.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:62:0) after 1m0s
[21:13:16.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:62:0)
[21:13:16.578] Timer tick, asking Buildbucket for the build status
[21:13:16.775] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:16.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:63:0) after 1m0s
[21:14:16.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:63:0)
[21:14:16.859] Timer tick, asking Buildbucket for the build status
[21:14:17.040] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.041] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:64:0) after 1m0s
[21:15:17.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:64:0)
[21:15:17.052] Timer tick, asking Buildbucket for the build status
[21:15:17.376] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:17.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:65:0) after 1m0s
[21:16:17.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:65:0)
[21:16:17.445] Timer tick, asking Buildbucket for the build status
[21:16:17.704] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:17.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:66:0) after 1m0s
[21:17:17.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:66:0)
[21:17:17.719] Timer tick, asking Buildbucket for the build status
[21:17:17.824] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:17.824] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:67:0) after 1m0s
[21:18:17.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:67:0)
[21:18:17.848] Timer tick, asking Buildbucket for the build status
[21:18:18.290] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:18.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:68:0) after 1m0s
[21:19:18.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:68:0)
[21:19:18.320] Timer tick, asking Buildbucket for the build status
[21:19:18.409] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:18.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:69:0) after 1m0s
[21:20:18.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:69:0)
[21:20:18.452] Timer tick, asking Buildbucket for the build status
[21:20:18.766] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:18.766] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:70:0) after 1m0s
[21:21:18.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:70:0)
[21:21:18.792] Timer tick, asking Buildbucket for the build status
[21:21:19.448] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:19.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:71:0) after 1m0s
[21:22:19.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:71:0)
[21:22:19.527] Timer tick, asking Buildbucket for the build status
[21:22:19.729] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:19.729] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:72:0) after 1m0s
[21:23:19.768] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:72:0)
[21:23:19.768] Timer tick, asking Buildbucket for the build status
[21:23:20.087] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:20.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:73:0) after 1m0s
[21:24:20.141] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:73:0)
[21:24:20.141] Timer tick, asking Buildbucket for the build status
[21:24:20.657] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:20.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:74:0) after 1m0s
[21:25:20.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:74:0)
[21:25:20.745] Timer tick, asking Buildbucket for the build status
[21:25:20.907] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:20.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:75:0) after 1m0s
[21:26:20.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:75:0)
[21:26:20.965] Timer tick, asking Buildbucket for the build status
[21:26:21.166] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:21.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:76:0) after 1m0s
[21:27:21.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:76:0)
[21:27:21.195] Timer tick, asking Buildbucket for the build status
[21:27:22.176] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:22.176] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:77:0) after 1m0s
[21:28:22.254] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:77:0)
[21:28:22.254] Timer tick, asking Buildbucket for the build status
[21:28:22.609] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:22.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:78:0) after 1m0s
[21:29:22.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:78:0)
[21:29:22.664] Timer tick, asking Buildbucket for the build status
[21:29:22.966] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:22.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:79:0) after 1m0s
[21:30:23.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:79:0)
[21:30:23.065] Timer tick, asking Buildbucket for the build status
[21:30:23.763] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:23.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:80:0) after 1m0s
[21:31:23.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:80:0)
[21:31:23.833] Timer tick, asking Buildbucket for the build status
[21:31:24.445] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:81:0) after 1m0s
[21:32:24.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:81:0)
[21:32:24.496] Timer tick, asking Buildbucket for the build status
[21:32:25.647] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:25.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:82:0) after 1m0s
[21:33:25.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:82:0)
[21:33:25.683] Timer tick, asking Buildbucket for the build status
[21:33:26.070] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:26.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:83:0) after 1m0s
[21:34:26.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:83:0)
[21:34:26.235] Timer tick, asking Buildbucket for the build status
[21:34:26.353] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:26.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:84:0) after 1m0s
[21:35:26.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:84:0)
[21:35:26.499] Timer tick, asking Buildbucket for the build status
[21:35:26.560] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:26.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:85:0) after 1m0s
[21:36:26.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:85:0)
[21:36:26.638] Timer tick, asking Buildbucket for the build status
[21:36:27.477] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:27.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:86:0) after 1m0s
[21:37:27.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:86:0)
[21:37:27.648] Timer tick, asking Buildbucket for the build status
[21:37:27.730] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:27.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:87:0) after 1m0s
[21:38:27.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:87:0)
[21:38:27.917] Timer tick, asking Buildbucket for the build status
[21:38:28.094] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:28.094] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:88:0) after 1m0s
[21:39:28.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:88:0)
[21:39:28.132] Timer tick, asking Buildbucket for the build status
[21:39:28.244] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:28.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:89:0) after 1m0s
[21:40:28.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:89:0)
[21:40:28.504] Timer tick, asking Buildbucket for the build status
[21:40:28.712] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:90:0) after 1m0s
[21:41:29.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:90:0)
[21:41:29.181] Timer tick, asking Buildbucket for the build status
[21:41:31.288] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:31.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:91:0) after 1m0s
[21:42:31.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:91:0)
[21:42:31.365] Timer tick, asking Buildbucket for the build status
[21:42:31.695] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:31.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:92:0) after 1m0s
[21:43:31.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:92:0)
[21:43:31.744] Timer tick, asking Buildbucket for the build status
[21:43:31.809] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:31.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:93:0) after 1m0s
[21:44:31.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:93:0)
[21:44:31.877] Timer tick, asking Buildbucket for the build status
[21:44:33.490] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:33.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:94:0) after 1m0s
[21:45:33.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:94:0)
[21:45:33.561] Timer tick, asking Buildbucket for the build status
[21:45:33.658] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:33.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:95:0) after 1m0s
[21:46:33.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:95:0)
[21:46:33.680] Timer tick, asking Buildbucket for the build status
[21:46:34.708] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:34.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:96:0) after 1m0s
[21:47:34.727] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:96:0)
[21:47:34.727] Timer tick, asking Buildbucket for the build status
[21:47:34.879] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:34.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:97:0) after 1m0s
[21:48:34.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:97:0)
[21:48:34.906] Timer tick, asking Buildbucket for the build status
[21:48:35.178] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:35.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:98:0) after 1m0s
[21:49:35.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:98:0)
[21:49:35.233] Timer tick, asking Buildbucket for the build status
[21:49:35.324] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:35.324] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:99:0) after 1m0s
[21:50:35.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:99:0)
[21:50:35.370] Timer tick, asking Buildbucket for the build status
[21:50:36.272] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:36.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:100:0) after 1m0s
[21:51:36.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:100:0)
[21:51:36.326] Timer tick, asking Buildbucket for the build status
[21:51:38.571] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:38.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:101:0) after 1m0s
[21:52:38.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:101:0)
[21:52:38.583] Timer tick, asking Buildbucket for the build status
[21:52:39.086] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:39.086] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:102:0) after 1m0s
[21:53:39.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:102:0)
[21:53:39.133] Timer tick, asking Buildbucket for the build status
[21:53:39.283] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:39.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:103:0) after 1m0s
[21:54:39.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:103:0)
[21:54:39.275] Timer tick, asking Buildbucket for the build status
[21:54:39.496] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:39.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:104:0) after 1m0s
[21:55:39.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:104:0)
[21:55:39.548] Timer tick, asking Buildbucket for the build status
[21:55:39.656] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:39.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:105:0) after 1m0s
[21:56:39.667] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:105:0)
[21:56:39.667] Timer tick, asking Buildbucket for the build status
[21:56:40.783] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:40.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:106:0) after 1m0s
[21:57:40.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:106:0)
[21:57:40.844] Timer tick, asking Buildbucket for the build status
[21:57:41.014] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:41.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:107:0) after 1m0s
[21:58:41.098] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:107:0)
[21:58:41.098] Timer tick, asking Buildbucket for the build status
[21:58:41.229] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:41.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:108:0) after 1m0s
[21:59:41.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:108:0)
[21:59:41.286] Timer tick, asking Buildbucket for the build status
[21:59:41.512] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:41.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:109:0) after 1m0s
[22:00:41.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:109:0)
[22:00:41.626] Timer tick, asking Buildbucket for the build status
[22:00:41.922] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:41.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:110:0) after 1m0s
[22:01:42.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:110:0)
[22:01:42.007] Timer tick, asking Buildbucket for the build status
[22:01:42.464] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:42.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:111:0) after 1m0s
[22:02:43.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:111:0)
[22:02:43.261] Timer tick, asking Buildbucket for the build status
[22:02:44.472] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:44.472] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:112:0) after 1m0s
[22:03:44.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:112:0)
[22:03:44.657] Timer tick, asking Buildbucket for the build status
[22:03:44.935] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:44.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:113:0) after 1m0s
[22:04:45.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:113:0)
[22:04:45.082] Timer tick, asking Buildbucket for the build status
[22:04:45.216] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:45.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:114:0) after 1m0s
[22:05:45.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:114:0)
[22:05:45.700] Timer tick, asking Buildbucket for the build status
[22:05:45.993] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:45.993] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:115:0) after 1m0s
[22:06:46.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:115:0)
[22:06:46.519] Timer tick, asking Buildbucket for the build status
[22:06:46.860] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:46.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:116:0) after 1m0s
[22:07:47.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:116:0)
[22:07:47.046] Timer tick, asking Buildbucket for the build status
[22:07:47.264] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:47.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:117:0) after 1m0s
[22:08:47.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:117:0)
[22:08:47.415] Timer tick, asking Buildbucket for the build status
[22:08:47.518] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:47.518] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:118:0) after 1m0s
[22:09:47.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:118:0)
[22:09:47.584] Timer tick, asking Buildbucket for the build status
[22:09:47.733] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:47.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:119:0) after 1m0s
[22:10:47.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:119:0)
[22:10:47.845] Timer tick, asking Buildbucket for the build status
[22:10:47.945] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:47.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:120:0) after 1m0s
[22:11:48.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:120:0)
[22:11:48.204] Timer tick, asking Buildbucket for the build status
[22:11:50.460] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:50.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:121:0) after 1m0s
[22:12:51.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:121:0)
[22:12:51.115] Timer tick, asking Buildbucket for the build status
[22:12:51.335] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:51.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:122:0) after 1m0s
[22:13:51.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:122:0)
[22:13:51.555] Timer tick, asking Buildbucket for the build status
[22:13:52.657] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:123:0) after 1m0s
[22:14:52.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:123:0)
[22:14:52.837] Timer tick, asking Buildbucket for the build status
[22:14:53.027] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:53.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:124:0) after 1m0s
[22:15:53.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:124:0)
[22:15:53.091] Timer tick, asking Buildbucket for the build status
[22:15:54.363] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:54.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:125:0) after 1m0s
[22:16:54.474] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:125:0)
[22:16:54.474] Timer tick, asking Buildbucket for the build status
[22:16:54.956] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:54.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:126:0) after 1m0s
[22:17:55.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:126:0)
[22:17:55.138] Timer tick, asking Buildbucket for the build status
[22:17:55.431] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:55.431] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:127:0) after 1m0s
[22:18:55.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:127:0)
[22:18:55.586] Timer tick, asking Buildbucket for the build status
[22:18:55.698] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:55.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:128:0) after 1m0s
[22:19:55.793] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:128:0)
[22:19:55.793] Timer tick, asking Buildbucket for the build status
[22:19:55.900] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:55.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:129:0) after 1m0s
[22:20:56.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:129:0)
[22:20:56.075] Timer tick, asking Buildbucket for the build status
[22:20:56.345] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:56.345] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:130:0) after 1m0s
[22:21:56.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:130:0)
[22:21:56.649] Timer tick, asking Buildbucket for the build status
[22:21:57.394] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:57.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:131:0) after 1m0s
[22:22:57.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:131:0)
[22:22:57.431] Timer tick, asking Buildbucket for the build status
[22:22:57.631] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:57.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:132:0) after 1m0s
[22:23:57.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:132:0)
[22:23:57.845] Timer tick, asking Buildbucket for the build status
[22:23:57.918] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:57.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:133:0) after 1m0s
[22:24:58.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:133:0)
[22:24:58.127] Timer tick, asking Buildbucket for the build status
[22:24:59.002] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:59.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:134:0) after 1m0s
[22:25:59.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:134:0)
[22:25:59.071] Timer tick, asking Buildbucket for the build status
[22:25:59.638] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:59.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:135:0) after 1m0s
[22:26:59.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:135:0)
[22:26:59.720] Timer tick, asking Buildbucket for the build status
[22:27:00.501] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:00.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:136:0) after 1m0s
[22:28:00.594] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:136:0)
[22:28:00.594] Timer tick, asking Buildbucket for the build status
[22:28:01.168] Build 8885459654573813264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:01.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050889717087993968:137:0) after 1m0s
[22:28:13.219] Received PubSub notification, asking Buildbucket for the build status
[22:28:13.589] Build 8885459654573813264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:28:13.589] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1584570492147981",
"created_by": "project:chromium",
"created_ts": "1584562360177551",
"id": "8885459654573813264",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5e20cc372436189fb52808adbaab4fb3a38ebd\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-39-3xcd\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27213, \"got_angle_revision\": \"78a85f2c18569fb86a9a286f74272ccf56ffabae\", \"got_dawn_revision\": \"83e138ca962c6c6b38f103081e898dfd74de2815\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"7f5e20cc372436189fb52808adbaab4fb3a38ebd\", \"got_revision_cp\": \"refs/heads/master@{#751454}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"dc0f1319307ee723c6e8a09f2ac7efd9d7bf70c3\", \"got_v8_revision\": \"6325afac4df4c1c0ab2a532c269e35b16cd6590c\", \"got_v8_revision_cp\": \"refs/heads/8.3.23@{#1}\", \"got_webrtc_revision\": \"ebf739be7bab158806c6cec117c0ac5af209b0a7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30821}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7f5e20cc372436189fb52808adbaab4fb3a38ebd\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1989594bdf03467d4cca251563547d36d290a477ee0cdac91b5f17239ddd8c8b_v2\", \"builder_26c11373d06d664e3b06c589165ec0844aa09020b59ada29c9f1bd40aa1cdc9d_v2\", \"builder_423310112abc51bdf46a1a7483fcbcb0b90f563663f848d5a0d953a5cff07510_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_97ff76ae173a9ce5e244c07639f8a3e6b9cacff7958414e43d82a5f30a20f3d2_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-39-3xcd\"], \"image\": [\"chrome-xenial-20031500-6b26172a85c\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4874-3598771\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1584562701467079",
"status": "COMPLETED",
"status_changed_ts": "1584570492657248",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27213",
"builder:Deterministic Linux",
"buildset:commit/git/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7f5e20cc372436189fb52808adbaab4fb3a38ebd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050889717087993968",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8885459654573813264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4b081996dd1c4510",
"user_agent:luci-scheduler"
],
"updated_ts": "1584570492665772",
"url": "https://ci.chromium.org/b/8885459654573813264",
"utcnow_ts": "1584570493570496"
}
}
[22:28:13.589] Invocation finished in 2h15m35.194093233s with status SUCCEEDED