[10:09:04.954] New invocation is queued and will start shortly
[10:09:10.330] Starting the invocation (attempt 1)
[10:09:10.364] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:09:10.364] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:09:10.364] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074664094848898464",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"16649706c906fff086a6b4bc1397b309e9ee1e9a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9074664094848898464",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"gitiles_ref:refs/heads/master"
]
}
[10:09:12.748] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561889351435027",
"id": "8909234027387615472",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"16649706c906fff086a6b4bc1397b309e9ee1e9a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561889352369539",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23923",
"builder:Deterministic Linux",
"buildset:commit/git/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074664094848898464",
"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/8909234027387615472/+/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": "1561889352369636",
"url": "https://ci.chromium.org/b/8909234027387615472",
"utcnow_ts": "1561889352723124"
}
}
[10:09:12.748] Task URL: https://ci.chromium.org/b/8909234027387615472
[10:09:12.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:2:0) after 1m0s
[10:10:13.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:2:0)
[10:10:13.502] Timer tick, asking Buildbucket for the build status
[10:10:13.733] Build 8909234027387615472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:10:13.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:3:0) after 1m0s
[10:11:13.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:3:0)
[10:11:13.754] Timer tick, asking Buildbucket for the build status
[10:11:14.581] Build 8909234027387615472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:11:14.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:4:0) after 1m0s
[10:12:14.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:4:0)
[10:12:14.682] Timer tick, asking Buildbucket for the build status
[10:12:14.826] Build 8909234027387615472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:12:14.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:5:0) after 1m0s
[10:13:14.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:5:0)
[10:13:14.970] Timer tick, asking Buildbucket for the build status
[10:13:15.099] Build 8909234027387615472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:13:15.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:6:0) after 1m0s
[10:14:15.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:6:0)
[10:14:15.135] Timer tick, asking Buildbucket for the build status
[10:14:16.501] Build 8909234027387615472: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:14:16.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:7:0) after 1m0s
[10:14:18.087] Received PubSub notification, asking Buildbucket for the build status
[10:14:18.296] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:16.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:7:0)
[10:15:16.591] Timer tick, asking Buildbucket for the build status
[10:15:16.882] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:16.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:9:0) after 1m0s
[10:16:16.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:9:0)
[10:16:16.996] Timer tick, asking Buildbucket for the build status
[10:16:17.278] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:17.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:10:0) after 1m0s
[10:17:17.344] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:10:0)
[10:17:17.344] Timer tick, asking Buildbucket for the build status
[10:17:17.908] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:17.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:11:0) after 1m0s
[10:18:17.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:11:0)
[10:18:17.992] Timer tick, asking Buildbucket for the build status
[10:18:18.992] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:18.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:12:0) after 1m0s
[10:19:19.025] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:12:0)
[10:19:19.025] Timer tick, asking Buildbucket for the build status
[10:19:19.610] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:19.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:13:0) after 1m0s
[10:20:19.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:13:0)
[10:20:19.657] Timer tick, asking Buildbucket for the build status
[10:20:20.289] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:20.289] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:14:0) after 1m0s
[10:21:20.323] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:14:0)
[10:21:20.323] Timer tick, asking Buildbucket for the build status
[10:21:20.492] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:20.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:15:0) after 1m0s
[10:22:20.540] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:15:0)
[10:22:20.540] Timer tick, asking Buildbucket for the build status
[10:22:20.777] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:20.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:16:0) after 1m0s
[10:23:20.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:16:0)
[10:23:20.796] Timer tick, asking Buildbucket for the build status
[10:23:21.875] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:21.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:17:0) after 1m0s
[10:24:21.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:17:0)
[10:24:21.950] Timer tick, asking Buildbucket for the build status
[10:24:22.174] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:22.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:18:0) after 1m0s
[10:25:22.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:18:0)
[10:25:22.296] Timer tick, asking Buildbucket for the build status
[10:25:22.459] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:22.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:19:0) after 1m0s
[10:26:22.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:19:0)
[10:26:22.514] Timer tick, asking Buildbucket for the build status
[10:26:22.693] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:22.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:20:0) after 1m0s
[10:27:22.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:20:0)
[10:27:22.801] Timer tick, asking Buildbucket for the build status
[10:27:22.953] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:22.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:21:0) after 1m0s
[10:28:22.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:21:0)
[10:28:22.973] Timer tick, asking Buildbucket for the build status
[10:28:23.238] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:23.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:22:0) after 1m0s
[10:29:23.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:22:0)
[10:29:23.229] Timer tick, asking Buildbucket for the build status
[10:29:24.053] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:24.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:23:0) after 1m0s
[10:30:24.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:23:0)
[10:30:24.127] Timer tick, asking Buildbucket for the build status
[10:30:24.285] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:24.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:24:0) after 1m0s
[10:31:24.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:24:0)
[10:31:24.306] Timer tick, asking Buildbucket for the build status
[10:31:24.918] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:24.918] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:25:0) after 1m0s
[10:32:24.949] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:25:0)
[10:32:24.949] Timer tick, asking Buildbucket for the build status
[10:32:25.165] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:25.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:26:0) after 1m0s
[10:33:25.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:26:0)
[10:33:25.220] Timer tick, asking Buildbucket for the build status
[10:33:25.331] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:27:0) after 1m0s
[10:34:25.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:27:0)
[10:34:25.466] Timer tick, asking Buildbucket for the build status
[10:34:25.615] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:25.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:28:0) after 1m0s
[10:35:25.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:28:0)
[10:35:25.663] Timer tick, asking Buildbucket for the build status
[10:35:25.800] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:25.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:29:0) after 1m0s
[10:36:25.822] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:29:0)
[10:36:25.822] Timer tick, asking Buildbucket for the build status
[10:36:25.954] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:25.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:30:0) after 1m0s
[10:37:25.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:30:0)
[10:37:25.982] Timer tick, asking Buildbucket for the build status
[10:37:26.111] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:26.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:31:0) after 1m0s
[10:38:26.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:31:0)
[10:38:26.142] Timer tick, asking Buildbucket for the build status
[10:38:26.326] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:26.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:32:0) after 1m0s
[10:39:26.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:32:0)
[10:39:26.347] Timer tick, asking Buildbucket for the build status
[10:39:26.460] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:26.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:33:0) after 1m0s
[10:40:26.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:33:0)
[10:40:26.482] Timer tick, asking Buildbucket for the build status
[10:40:26.616] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:26.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:34:0) after 1m0s
[10:41:26.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:34:0)
[10:41:26.650] Timer tick, asking Buildbucket for the build status
[10:41:26.838] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:26.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:35:0) after 1m0s
[10:42:26.856] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:35:0)
[10:42:26.856] Timer tick, asking Buildbucket for the build status
[10:42:27.989] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:27.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:36:0) after 1m0s
[10:43:28.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:36:0)
[10:43:28.018] Timer tick, asking Buildbucket for the build status
[10:43:28.525] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:28.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:37:0) after 1m0s
[10:44:28.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:37:0)
[10:44:28.544] Timer tick, asking Buildbucket for the build status
[10:44:28.656] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:28.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:38:0) after 1m0s
[10:45:28.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:38:0)
[10:45:28.679] Timer tick, asking Buildbucket for the build status
[10:45:28.874] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:28.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:39:0) after 1m0s
[10:46:46.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:39:0)
[10:46:46.857] Timer tick, asking Buildbucket for the build status
[10:46:47.091] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:47.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:40:0) after 1m0s
[10:47:47.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:40:0)
[10:47:47.149] Timer tick, asking Buildbucket for the build status
[10:47:47.929] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:47.929] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:41:0) after 1m0s
[10:48:47.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:41:0)
[10:48:47.951] Timer tick, asking Buildbucket for the build status
[10:48:48.536] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:48.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:42:0) after 1m0s
[10:49:48.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:42:0)
[10:49:48.810] Timer tick, asking Buildbucket for the build status
[10:49:48.987] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:48.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:43:0) after 1m0s
[10:50:49.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:43:0)
[10:50:49.212] Timer tick, asking Buildbucket for the build status
[10:50:50.230] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:50.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:44:0) after 1m0s
[10:51:50.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:44:0)
[10:51:50.432] Timer tick, asking Buildbucket for the build status
[10:51:50.741] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:50.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:45:0) after 1m0s
[10:52:50.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:45:0)
[10:52:50.977] Timer tick, asking Buildbucket for the build status
[10:52:51.448] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:51.448] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:46:0) after 1m0s
[10:53:51.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:46:0)
[10:53:51.531] Timer tick, asking Buildbucket for the build status
[10:53:53.728] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:53.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:47:0) after 1m0s
[10:54:53.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:47:0)
[10:54:53.751] Timer tick, asking Buildbucket for the build status
[10:54:55.152] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:55.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:48:0) after 1m0s
[10:55:55.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:48:0)
[10:55:55.324] Timer tick, asking Buildbucket for the build status
[10:55:55.438] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:55.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:49:0) after 1m0s
[10:56:55.534] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:49:0)
[10:56:55.534] Timer tick, asking Buildbucket for the build status
[10:56:55.677] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:55.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:50:0) after 1m0s
[10:57:55.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:50:0)
[10:57:55.721] Timer tick, asking Buildbucket for the build status
[10:57:55.898] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:55.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:51:0) after 1m0s
[10:58:56.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:51:0)
[10:58:56.053] Timer tick, asking Buildbucket for the build status
[10:59:01.987] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:01.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:52:0) after 1m0s
[11:00:02.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:52:0)
[11:00:02.395] Timer tick, asking Buildbucket for the build status
[11:00:02.960] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:02.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:53:0) after 1m0s
[11:01:03.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:53:0)
[11:01:03.167] Timer tick, asking Buildbucket for the build status
[11:01:03.843] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:03.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:54:0) after 1m0s
[11:02:04.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:54:0)
[11:02:04.365] Timer tick, asking Buildbucket for the build status
[11:02:05.188] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:05.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:55:0) after 1m0s
[11:03:05.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:55:0)
[11:03:05.358] Timer tick, asking Buildbucket for the build status
[11:03:06.141] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:06.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:56:0) after 1m0s
[11:04:06.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:56:0)
[11:04:06.285] Timer tick, asking Buildbucket for the build status
[11:04:06.481] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:06.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:57:0) after 1m0s
[11:05:06.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:57:0)
[11:05:06.504] Timer tick, asking Buildbucket for the build status
[11:05:07.061] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:07.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:58:0) after 1m0s
[11:06:07.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:58:0)
[11:06:07.185] Timer tick, asking Buildbucket for the build status
[11:06:08.329] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:08.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:59:0) after 1m0s
[11:07:08.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:59:0)
[11:07:08.497] Timer tick, asking Buildbucket for the build status
[11:07:09.602] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:09.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:60:0) after 1m0s
[11:08:09.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:60:0)
[11:08:09.933] Timer tick, asking Buildbucket for the build status
[11:08:10.109] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:10.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:61:0) after 1m0s
[11:09:10.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:61:0)
[11:09:10.170] Timer tick, asking Buildbucket for the build status
[11:09:10.342] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:10.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:62:0) after 1m0s
[11:10:10.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:62:0)
[11:10:10.743] Timer tick, asking Buildbucket for the build status
[11:10:10.853] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:10.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:63:0) after 1m0s
[11:11:11.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:63:0)
[11:11:11.096] Timer tick, asking Buildbucket for the build status
[11:11:11.917] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:11.917] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:64:0) after 1m0s
[11:12:12.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:64:0)
[11:12:12.237] Timer tick, asking Buildbucket for the build status
[11:12:12.376] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:12.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:65:0) after 1m0s
[11:13:12.403] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:65:0)
[11:13:12.403] Timer tick, asking Buildbucket for the build status
[11:13:13.409] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:13.409] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:66:0) after 1m0s
[11:14:13.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:66:0)
[11:14:13.457] Timer tick, asking Buildbucket for the build status
[11:14:13.735] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:13.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:67:0) after 1m0s
[11:15:13.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:67:0)
[11:15:13.759] Timer tick, asking Buildbucket for the build status
[11:15:14.711] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:14.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:68:0) after 1m0s
[11:16:14.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:68:0)
[11:16:14.735] Timer tick, asking Buildbucket for the build status
[11:16:14.937] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:14.937] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:69:0) after 1m0s
[11:17:14.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:69:0)
[11:17:14.983] Timer tick, asking Buildbucket for the build status
[11:17:15.261] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:70:0) after 1m0s
[11:18:15.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:70:0)
[11:18:15.284] Timer tick, asking Buildbucket for the build status
[11:18:15.536] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:15.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:71:0) after 1m0s
[11:19:15.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:71:0)
[11:19:15.648] Timer tick, asking Buildbucket for the build status
[11:19:16.548] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:16.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:72:0) after 1m0s
[11:20:16.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:72:0)
[11:20:16.576] Timer tick, asking Buildbucket for the build status
[11:20:16.694] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:16.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:73:0) after 1m0s
[11:21:16.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:73:0)
[11:21:16.719] Timer tick, asking Buildbucket for the build status
[11:21:17.948] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:17.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:74:0) after 1m0s
[11:22:17.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:74:0)
[11:22:17.962] Timer tick, asking Buildbucket for the build status
[11:22:18.203] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.203] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:75:0) after 1m0s
[11:23:18.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:75:0)
[11:23:18.230] Timer tick, asking Buildbucket for the build status
[11:23:18.754] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:18.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:76:0) after 1m0s
[11:24:18.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:76:0)
[11:24:18.849] Timer tick, asking Buildbucket for the build status
[11:24:19.310] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:19.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:77:0) after 1m0s
[11:25:19.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:77:0)
[11:25:19.443] Timer tick, asking Buildbucket for the build status
[11:25:19.948] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:19.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:78:0) after 1m0s
[11:26:20.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:78:0)
[11:26:20.078] Timer tick, asking Buildbucket for the build status
[11:26:20.532] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:20.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:79:0) after 1m0s
[11:27:20.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:79:0)
[11:27:20.556] Timer tick, asking Buildbucket for the build status
[11:27:20.856] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:20.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:80:0) after 1m0s
[11:28:20.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:80:0)
[11:28:20.878] Timer tick, asking Buildbucket for the build status
[11:28:21.042] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:21.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:81:0) after 1m0s
[11:29:21.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:81:0)
[11:29:21.645] Timer tick, asking Buildbucket for the build status
[11:29:21.778] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:21.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:82:0) after 1m0s
[11:30:22.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:82:0)
[11:30:22.299] Timer tick, asking Buildbucket for the build status
[11:30:23.130] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:23.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:83:0) after 1m0s
[11:31:23.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:83:0)
[11:31:23.161] Timer tick, asking Buildbucket for the build status
[11:31:23.376] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:23.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:84:0) after 1m0s
[11:32:23.472] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:84:0)
[11:32:23.472] Timer tick, asking Buildbucket for the build status
[11:32:23.631] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:23.631] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:85:0) after 1m0s
[11:33:23.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:85:0)
[11:33:23.662] Timer tick, asking Buildbucket for the build status
[11:33:23.789] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:23.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:86:0) after 1m0s
[11:34:23.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:86:0)
[11:34:23.859] Timer tick, asking Buildbucket for the build status
[11:34:24.315] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:24.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:87:0) after 1m0s
[11:35:24.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:87:0)
[11:35:24.322] Timer tick, asking Buildbucket for the build status
[11:35:24.471] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:24.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:88:0) after 1m0s
[11:36:24.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:88:0)
[11:36:24.497] Timer tick, asking Buildbucket for the build status
[11:36:24.683] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:24.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:89:0) after 1m0s
[11:37:24.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:89:0)
[11:37:24.690] Timer tick, asking Buildbucket for the build status
[11:37:24.886] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:24.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:90:0) after 1m0s
[11:38:24.919] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:90:0)
[11:38:24.919] Timer tick, asking Buildbucket for the build status
[11:38:25.083] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:25.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:91:0) after 1m0s
[11:39:25.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:91:0)
[11:39:25.077] Timer tick, asking Buildbucket for the build status
[11:39:25.331] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:25.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:92:0) after 1m0s
[11:40:25.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:92:0)
[11:40:25.353] Timer tick, asking Buildbucket for the build status
[11:40:26.450] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:26.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:93:0) after 1m0s
[11:41:26.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:93:0)
[11:41:26.475] Timer tick, asking Buildbucket for the build status
[11:41:26.943] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:26.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:94:0) after 1m0s
[11:42:27.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:94:0)
[11:42:27.122] Timer tick, asking Buildbucket for the build status
[11:42:27.656] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:27.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:95:0) after 1m0s
[11:43:28.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:95:0)
[11:43:28.232] Timer tick, asking Buildbucket for the build status
[11:43:28.593] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:28.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:96:0) after 1m0s
[11:44:28.917] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:96:0)
[11:44:28.917] Timer tick, asking Buildbucket for the build status
[11:44:29.063] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:29.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:97:0) after 1m0s
[11:45:29.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:97:0)
[11:45:29.717] Timer tick, asking Buildbucket for the build status
[11:45:29.853] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:29.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:98:0) after 1m0s
[11:46:30.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:98:0)
[11:46:30.275] Timer tick, asking Buildbucket for the build status
[11:46:30.415] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:30.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:99:0) after 1m0s
[11:47:30.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:99:0)
[11:47:30.435] Timer tick, asking Buildbucket for the build status
[11:47:30.921] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:30.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:100:0) after 1m0s
[11:48:30.898] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:100:0)
[11:48:30.898] Timer tick, asking Buildbucket for the build status
[11:48:31.048] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:31.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:101:0) after 1m0s
[11:49:31.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:101:0)
[11:49:31.115] Timer tick, asking Buildbucket for the build status
[11:49:31.247] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:102:0) after 1m0s
[11:50:31.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:102:0)
[11:50:31.483] Timer tick, asking Buildbucket for the build status
[11:50:31.848] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:31.848] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:103:0) after 1m0s
[11:51:31.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:103:0)
[11:51:31.957] Timer tick, asking Buildbucket for the build status
[11:51:32.209] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:32.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:104:0) after 1m0s
[11:52:32.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:104:0)
[11:52:32.347] Timer tick, asking Buildbucket for the build status
[11:52:32.495] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:32.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:105:0) after 1m0s
[11:53:33.099] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:105:0)
[11:53:33.099] Timer tick, asking Buildbucket for the build status
[11:53:33.222] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:33.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:106:0) after 1m0s
[11:54:33.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:106:0)
[11:54:33.347] Timer tick, asking Buildbucket for the build status
[11:54:33.512] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:33.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:107:0) after 1m0s
[11:55:33.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:107:0)
[11:55:33.546] Timer tick, asking Buildbucket for the build status
[11:55:34.398] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:34.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:108:0) after 1m0s
[11:56:34.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:108:0)
[11:56:34.584] Timer tick, asking Buildbucket for the build status
[11:56:34.708] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:34.708] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:109:0) after 1m0s
[11:57:34.903] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:109:0)
[11:57:34.903] Timer tick, asking Buildbucket for the build status
[11:57:35.453] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:35.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:110:0) after 1m0s
[11:58:35.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:110:0)
[11:58:35.766] Timer tick, asking Buildbucket for the build status
[11:58:36.411] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:36.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:111:0) after 1m0s
[11:59:36.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:111:0)
[11:59:36.582] Timer tick, asking Buildbucket for the build status
[11:59:37.176] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:37.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:112:0) after 1m0s
[12:00:37.349] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:112:0)
[12:00:37.349] Timer tick, asking Buildbucket for the build status
[12:00:37.501] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:37.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:113:0) after 1m0s
[12:01:37.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:113:0)
[12:01:37.783] Timer tick, asking Buildbucket for the build status
[12:01:37.934] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:37.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:114:0) after 1m0s
[12:02:38.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:114:0)
[12:02:38.049] Timer tick, asking Buildbucket for the build status
[12:02:38.533] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:38.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:115:0) after 1m0s
[12:03:38.565] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:115:0)
[12:03:38.565] Timer tick, asking Buildbucket for the build status
[12:03:38.699] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:38.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:116:0) after 1m0s
[12:04:39.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:116:0)
[12:04:39.055] Timer tick, asking Buildbucket for the build status
[12:04:39.389] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:39.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:117:0) after 1m0s
[12:05:39.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:117:0)
[12:05:39.495] Timer tick, asking Buildbucket for the build status
[12:05:39.673] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:39.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:118:0) after 1m0s
[12:06:39.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:118:0)
[12:06:39.670] Timer tick, asking Buildbucket for the build status
[12:06:39.821] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:39.821] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:119:0) after 1m0s
[12:07:39.935] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:119:0)
[12:07:39.935] Timer tick, asking Buildbucket for the build status
[12:07:40.094] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:40.094] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:120:0) after 1m0s
[12:08:40.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:120:0)
[12:08:40.116] Timer tick, asking Buildbucket for the build status
[12:08:40.557] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:40.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:121:0) after 1m0s
[12:09:40.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:121:0)
[12:09:40.581] Timer tick, asking Buildbucket for the build status
[12:09:41.840] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:41.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:122:0) after 1m0s
[12:10:41.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:122:0)
[12:10:41.862] Timer tick, asking Buildbucket for the build status
[12:10:42.033] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:42.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:123:0) after 1m0s
[12:11:42.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:123:0)
[12:11:42.057] Timer tick, asking Buildbucket for the build status
[12:11:42.177] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:42.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:124:0) after 1m0s
[12:12:42.685] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:124:0)
[12:12:42.685] Timer tick, asking Buildbucket for the build status
[12:12:43.084] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:43.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:125:0) after 1m0s
[12:13:43.148] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:125:0)
[12:13:43.148] Timer tick, asking Buildbucket for the build status
[12:13:43.979] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:43.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:126:0) after 1m0s
[12:14:44.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:126:0)
[12:14:44.066] Timer tick, asking Buildbucket for the build status
[12:14:44.239] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:44.239] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:127:0) after 1m0s
[12:15:44.373] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:127:0)
[12:15:44.373] Timer tick, asking Buildbucket for the build status
[12:15:44.557] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:44.557] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:128:0) after 1m0s
[12:16:44.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:128:0)
[12:16:44.599] Timer tick, asking Buildbucket for the build status
[12:16:44.743] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:44.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:129:0) after 1m0s
[12:17:45.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:129:0)
[12:17:45.467] Timer tick, asking Buildbucket for the build status
[12:17:46.661] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:46.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:130:0) after 1m0s
[12:18:46.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:130:0)
[12:18:46.684] Timer tick, asking Buildbucket for the build status
[12:18:47.367] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:47.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:131:0) after 1m0s
[12:19:47.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:131:0)
[12:19:47.571] Timer tick, asking Buildbucket for the build status
[12:19:47.687] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:47.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:132:0) after 1m0s
[12:20:47.960] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:132:0)
[12:20:47.960] Timer tick, asking Buildbucket for the build status
[12:20:48.174] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:48.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:133:0) after 1m0s
[12:21:48.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:133:0)
[12:21:48.376] Timer tick, asking Buildbucket for the build status
[12:21:48.559] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:48.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:134:0) after 1m0s
[12:22:48.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:134:0)
[12:22:48.728] Timer tick, asking Buildbucket for the build status
[12:22:49.440] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:49.440] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:135:0) after 1m0s
[12:23:49.579] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:135:0)
[12:23:49.579] Timer tick, asking Buildbucket for the build status
[12:23:49.806] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:49.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:136:0) after 1m0s
[12:24:49.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:136:0)
[12:24:49.835] Timer tick, asking Buildbucket for the build status
[12:24:51.525] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:51.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:137:0) after 1m0s
[12:25:51.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:137:0)
[12:25:51.819] Timer tick, asking Buildbucket for the build status
[12:25:52.736] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:52.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:138:0) after 1m0s
[12:26:52.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:138:0)
[12:26:52.962] Timer tick, asking Buildbucket for the build status
[12:26:53.112] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:53.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:139:0) after 1m0s
[12:27:53.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:139:0)
[12:27:53.201] Timer tick, asking Buildbucket for the build status
[12:27:53.443] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:53.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:140:0) after 1m0s
[12:28:53.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:140:0)
[12:28:53.485] Timer tick, asking Buildbucket for the build status
[12:28:53.646] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:53.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:141:0) after 1m0s
[12:29:53.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:141:0)
[12:29:53.835] Timer tick, asking Buildbucket for the build status
[12:29:54.228] Build 8909234027387615472: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:54.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9074664094848898464:142:0) after 1m0s
[12:30:06.886] Received PubSub notification, asking Buildbucket for the build status
[12:30:07.084] Build 8909234027387615472: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:30:07.084] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561897805798282",
"created_by": "project:chromium",
"created_ts": "1561889351435027",
"id": "8909234027387615472",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"16649706c906fff086a6b4bc1397b309e9ee1e9a\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-trusty-8-31-g8d1\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23923, \"got_angle_revision\": \"f116aa9c158b91bc966ef0394d666da4b3e7bcb6\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"16649706c906fff086a6b4bc1397b309e9ee1e9a\", \"got_revision_cp\": \"refs/heads/master@{#673609}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"45ddaacef4d3cd90c58d766380fc1f418f998cd2\", \"got_v8_revision_cp\": \"refs/heads/7.7.166@{#1}\", \"got_webrtc_revision\": \"2ce1da53283cd87219fcd111dcf2c60eb613c79f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28422}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"16649706c906fff086a6b4bc1397b309e9ee1e9a\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_344fdbb0645db34abb0ba2234526d11ebdee57216f7b28618f17626659f7ae86_v2\", \"builder_360e090537af5d0e85670c6ae42c4dc4bbec8921cc650184022f9d46f257e3c4_v2\", \"builder_9abb531f9fa28fcfd3ce68b2370bf6d67201ddb083beddbd2671f7c5fe25be9e_v2\", \"builder_b75dae3e256987d276902f5f82eb7d6f9dd38c954d991608166704214caef6db_v2\", \"builder_bb898022d2469672cf25def24fe6674f04bc82432723cbfd6a0db18494567798_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-31-g8d1\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4351-b85b41c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561889656302800",
"status": "COMPLETED",
"status_changed_ts": "1561897806095053",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23923",
"builder:Deterministic Linux",
"buildset:commit/git/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/16649706c906fff086a6b4bc1397b309e9ee1e9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074664094848898464",
"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/8909234027387615472/+/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:45c0ae1d431d7c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1561897806104546",
"url": "https://ci.chromium.org/b/8909234027387615472",
"utcnow_ts": "1561897807065161"
}
}
[12:30:07.084] Invocation finished in 2h21m2.147917731s with status SUCCEEDED