[09:10:00.677] New invocation is queued and will start shortly
[09:10:01.754] Starting the invocation (attempt 1)
[09:10:01.840] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:10:01.840] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:10:01.840] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054736478683246880",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1cb0d64a30282f19d8592bb3f6855274830dbad7\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9054736478683246880",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"gitiles_ref:refs/heads/master"
]
}
[09:10:02.544] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580893801981771",
"id": "8889306416651793808",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1cb0d64a30282f19d8592bb3f6855274830dbad7\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580893802384522",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26713",
"builder:Deterministic Linux",
"buildset:commit/git/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054736478683246880",
"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/8889306416651793808/+/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": "1580893802384684",
"url": "https://ci.chromium.org/b/8889306416651793808",
"utcnow_ts": "1580893802529147"
}
}
[09:10:02.544] Task URL: https://ci.chromium.org/b/8889306416651793808
[09:10:02.544] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:2:0) after 1m0s
[09:11:02.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:2:0)
[09:11:02.546] Timer tick, asking Buildbucket for the build status
[09:11:02.735] Build 8889306416651793808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:11:02.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:3:0) after 1m0s
[09:12:02.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:3:0)
[09:12:02.948] Timer tick, asking Buildbucket for the build status
[09:12:03.156] Build 8889306416651793808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:12:03.156] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:4:0) after 1m0s
[09:13:03.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:4:0)
[09:13:03.378] Timer tick, asking Buildbucket for the build status
[09:13:03.505] Build 8889306416651793808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:13:03.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:5:0) after 1m0s
[09:14:03.596] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:5:0)
[09:14:03.596] Timer tick, asking Buildbucket for the build status
[09:14:03.804] Build 8889306416651793808: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:14:03.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:6:0) after 1m0s
[09:15:02.587] Received PubSub notification, asking Buildbucket for the build status
[09:15:02.968] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:03.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:6:0)
[09:15:03.857] Timer tick, asking Buildbucket for the build status
[09:15:04.701] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:04.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:8:0) after 1m0s
[09:16:04.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:8:0)
[09:16:04.788] Timer tick, asking Buildbucket for the build status
[09:16:05.119] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:05.120] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:9:0) after 1m0s
[09:17:05.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:9:0)
[09:17:05.218] Timer tick, asking Buildbucket for the build status
[09:17:06.108] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:06.108] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:10:0) after 1m0s
[09:18:06.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:10:0)
[09:18:06.189] Timer tick, asking Buildbucket for the build status
[09:18:06.356] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:06.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:11:0) after 1m0s
[09:19:06.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:11:0)
[09:19:06.427] Timer tick, asking Buildbucket for the build status
[09:19:07.174] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:07.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:12:0) after 1m0s
[09:20:07.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:12:0)
[09:20:07.231] Timer tick, asking Buildbucket for the build status
[09:20:08.177] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:08.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:13:0) after 1m0s
[09:21:08.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:13:0)
[09:21:08.327] Timer tick, asking Buildbucket for the build status
[09:21:08.772] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:08.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:14:0) after 1m0s
[09:22:08.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:14:0)
[09:22:08.841] Timer tick, asking Buildbucket for the build status
[09:22:09.023] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:09.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:15:0) after 1m0s
[09:23:09.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:15:0)
[09:23:09.065] Timer tick, asking Buildbucket for the build status
[09:23:09.592] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:09.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:16:0) after 1m0s
[09:24:09.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:16:0)
[09:24:09.621] Timer tick, asking Buildbucket for the build status
[09:24:09.892] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:09.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:17:0) after 1m0s
[09:25:10.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:17:0)
[09:25:10.058] Timer tick, asking Buildbucket for the build status
[09:25:10.245] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:10.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:18:0) after 1m0s
[09:26:10.332] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:18:0)
[09:26:10.332] Timer tick, asking Buildbucket for the build status
[09:26:10.575] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:10.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:19:0) after 1m0s
[09:27:10.639] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:19:0)
[09:27:10.639] Timer tick, asking Buildbucket for the build status
[09:27:11.651] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:11.651] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:20:0) after 1m0s
[09:28:11.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:20:0)
[09:28:11.673] Timer tick, asking Buildbucket for the build status
[09:28:11.884] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:11.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:21:0) after 1m0s
[09:29:11.933] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:21:0)
[09:29:11.933] Timer tick, asking Buildbucket for the build status
[09:29:12.282] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:12.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:22:0) after 1m0s
[09:30:12.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:22:0)
[09:30:12.299] Timer tick, asking Buildbucket for the build status
[09:30:12.568] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:12.568] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:23:0) after 1m0s
[09:31:12.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:23:0)
[09:31:12.592] Timer tick, asking Buildbucket for the build status
[09:31:13.164] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:13.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:24:0) after 1m0s
[09:32:13.236] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:24:0)
[09:32:13.236] Timer tick, asking Buildbucket for the build status
[09:32:13.558] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:25:0) after 1m0s
[09:33:13.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:25:0)
[09:33:13.645] Timer tick, asking Buildbucket for the build status
[09:33:14.433] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:14.433] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:26:0) after 1m0s
[09:34:14.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:26:0)
[09:34:14.510] Timer tick, asking Buildbucket for the build status
[09:34:14.807] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:14.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:27:0) after 1m0s
[09:35:14.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:27:0)
[09:35:14.841] Timer tick, asking Buildbucket for the build status
[09:35:15.508] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:15.508] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:28:0) after 1m0s
[09:36:15.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:28:0)
[09:36:15.643] Timer tick, asking Buildbucket for the build status
[09:36:15.780] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:15.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:29:0) after 1m0s
[09:37:15.886] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:29:0)
[09:37:15.886] Timer tick, asking Buildbucket for the build status
[09:37:16.218] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:16.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:30:0) after 1m0s
[09:38:16.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:30:0)
[09:38:16.280] Timer tick, asking Buildbucket for the build status
[09:38:16.695] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:16.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:31:0) after 1m0s
[09:39:16.874] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:31:0)
[09:39:16.874] Timer tick, asking Buildbucket for the build status
[09:39:18.037] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:18.037] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:32:0) after 1m0s
[09:40:18.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:32:0)
[09:40:18.016] Timer tick, asking Buildbucket for the build status
[09:40:18.224] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:18.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:33:0) after 1m0s
[09:41:18.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:33:0)
[09:41:18.462] Timer tick, asking Buildbucket for the build status
[09:41:18.645] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:18.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:34:0) after 1m0s
[09:42:18.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:34:0)
[09:42:18.982] Timer tick, asking Buildbucket for the build status
[09:42:21.224] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:21.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:35:0) after 1m0s
[09:43:21.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:35:0)
[09:43:21.244] Timer tick, asking Buildbucket for the build status
[09:43:22.830] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:22.830] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:36:0) after 1m0s
[09:44:22.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:36:0)
[09:44:22.971] Timer tick, asking Buildbucket for the build status
[09:44:23.407] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:23.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:37:0) after 1m0s
[09:45:23.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:37:0)
[09:45:23.630] Timer tick, asking Buildbucket for the build status
[09:45:23.792] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:23.792] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:38:0) after 1m0s
[09:46:24.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:38:0)
[09:46:24.029] Timer tick, asking Buildbucket for the build status
[09:46:24.326] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:24.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:39:0) after 1m0s
[09:47:24.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:39:0)
[09:47:24.371] Timer tick, asking Buildbucket for the build status
[09:47:24.543] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:24.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:40:0) after 1m0s
[09:48:24.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:40:0)
[09:48:24.780] Timer tick, asking Buildbucket for the build status
[09:48:24.960] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:24.960] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:41:0) after 1m0s
[09:49:25.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:41:0)
[09:49:25.196] Timer tick, asking Buildbucket for the build status
[09:49:25.429] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:25.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:42:0) after 1m0s
[09:50:25.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:42:0)
[09:50:25.549] Timer tick, asking Buildbucket for the build status
[09:50:25.760] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:25.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:43:0) after 1m0s
[09:51:26.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:43:0)
[09:51:26.069] Timer tick, asking Buildbucket for the build status
[09:51:26.220] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:26.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:44:0) after 1m0s
[09:52:26.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:44:0)
[09:52:26.197] Timer tick, asking Buildbucket for the build status
[09:52:26.507] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:26.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:45:0) after 1m0s
[09:53:26.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:45:0)
[09:53:26.629] Timer tick, asking Buildbucket for the build status
[09:53:27.593] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:27.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:46:0) after 1m0s
[09:54:27.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:46:0)
[09:54:27.661] Timer tick, asking Buildbucket for the build status
[09:54:28.387] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:28.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:47:0) after 1m0s
[09:55:28.434] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:47:0)
[09:55:28.434] Timer tick, asking Buildbucket for the build status
[09:55:28.687] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:28.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:48:0) after 1m0s
[09:56:28.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:48:0)
[09:56:28.710] Timer tick, asking Buildbucket for the build status
[09:56:28.975] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:28.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:49:0) after 1m0s
[09:57:28.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:49:0)
[09:57:28.966] Timer tick, asking Buildbucket for the build status
[09:57:29.315] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:29.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:50:0) after 1m0s
[09:58:29.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:50:0)
[09:58:29.388] Timer tick, asking Buildbucket for the build status
[09:58:29.579] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:29.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:51:0) after 1m0s
[09:59:29.601] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:51:0)
[09:59:29.601] Timer tick, asking Buildbucket for the build status
[09:59:29.777] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:29.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:52:0) after 1m0s
[10:00:29.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:52:0)
[10:00:29.814] Timer tick, asking Buildbucket for the build status
[10:00:29.982] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:29.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:53:0) after 1m0s
[10:01:30.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:53:0)
[10:01:30.085] Timer tick, asking Buildbucket for the build status
[10:01:30.231] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:30.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:54:0) after 1m0s
[10:02:30.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:54:0)
[10:02:30.330] Timer tick, asking Buildbucket for the build status
[10:02:30.551] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:30.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:55:0) after 1m0s
[10:03:30.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:55:0)
[10:03:30.612] Timer tick, asking Buildbucket for the build status
[10:03:30.949] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:30.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:56:0) after 1m0s
[10:04:31.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:56:0)
[10:04:31.011] Timer tick, asking Buildbucket for the build status
[10:04:32.187] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:32.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:57:0) after 1m0s
[10:05:32.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:57:0)
[10:05:32.212] Timer tick, asking Buildbucket for the build status
[10:05:32.357] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:32.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:58:0) after 1m0s
[10:06:32.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:58:0)
[10:06:32.370] Timer tick, asking Buildbucket for the build status
[10:06:32.595] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:32.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:59:0) after 1m0s
[10:07:32.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:59:0)
[10:07:32.672] Timer tick, asking Buildbucket for the build status
[10:07:32.836] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:32.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:60:0) after 1m0s
[10:08:32.834] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:60:0)
[10:08:32.834] Timer tick, asking Buildbucket for the build status
[10:08:33.034] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:33.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:61:0) after 1m0s
[10:09:33.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:61:0)
[10:09:33.064] Timer tick, asking Buildbucket for the build status
[10:09:33.243] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:33.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:62:0) after 1m0s
[10:10:33.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:62:0)
[10:10:33.288] Timer tick, asking Buildbucket for the build status
[10:10:33.502] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:33.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:63:0) after 1m0s
[10:11:33.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:63:0)
[10:11:33.557] Timer tick, asking Buildbucket for the build status
[10:11:33.831] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:33.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:64:0) after 1m0s
[10:12:33.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:64:0)
[10:12:33.884] Timer tick, asking Buildbucket for the build status
[10:12:34.082] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:34.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:65:0) after 1m0s
[10:13:34.181] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:65:0)
[10:13:34.181] Timer tick, asking Buildbucket for the build status
[10:13:34.394] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:34.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:66:0) after 1m0s
[10:14:34.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:66:0)
[10:14:34.368] Timer tick, asking Buildbucket for the build status
[10:14:35.146] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:35.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:67:0) after 1m0s
[10:15:35.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:67:0)
[10:15:35.169] Timer tick, asking Buildbucket for the build status
[10:15:35.333] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:35.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:68:0) after 1m0s
[10:16:35.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:68:0)
[10:16:35.468] Timer tick, asking Buildbucket for the build status
[10:16:35.859] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:35.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:69:0) after 1m0s
[10:17:35.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:69:0)
[10:17:35.866] Timer tick, asking Buildbucket for the build status
[10:17:36.209] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:70:0) after 1m0s
[10:18:36.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:70:0)
[10:18:36.285] Timer tick, asking Buildbucket for the build status
[10:18:36.459] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:36.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:71:0) after 1m0s
[10:19:36.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:71:0)
[10:19:36.473] Timer tick, asking Buildbucket for the build status
[10:19:36.634] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:36.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:72:0) after 1m0s
[10:20:36.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:72:0)
[10:20:36.665] Timer tick, asking Buildbucket for the build status
[10:20:36.926] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:73:0) after 1m0s
[10:21:36.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:73:0)
[10:21:36.984] Timer tick, asking Buildbucket for the build status
[10:21:37.179] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:37.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:74:0) after 1m0s
[10:22:37.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:74:0)
[10:22:37.180] Timer tick, asking Buildbucket for the build status
[10:22:38.220] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:38.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:75:0) after 1m0s
[10:23:38.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:75:0)
[10:23:38.278] Timer tick, asking Buildbucket for the build status
[10:23:38.549] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:38.549] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:76:0) after 1m0s
[10:24:38.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:76:0)
[10:24:38.575] Timer tick, asking Buildbucket for the build status
[10:24:39.417] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:39.417] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:77:0) after 1m0s
[10:25:39.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:77:0)
[10:25:39.470] Timer tick, asking Buildbucket for the build status
[10:25:39.655] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:39.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:78:0) after 1m0s
[10:26:39.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:78:0)
[10:26:39.837] Timer tick, asking Buildbucket for the build status
[10:26:40.416] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:40.416] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:79:0) after 1m0s
[10:27:40.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:79:0)
[10:27:40.446] Timer tick, asking Buildbucket for the build status
[10:27:40.971] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:40.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:80:0) after 1m0s
[10:28:40.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:80:0)
[10:28:40.953] Timer tick, asking Buildbucket for the build status
[10:28:41.574] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:41.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:81:0) after 1m0s
[10:29:41.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:81:0)
[10:29:41.625] Timer tick, asking Buildbucket for the build status
[10:29:41.966] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:41.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:82:0) after 1m0s
[10:30:42.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:82:0)
[10:30:42.057] Timer tick, asking Buildbucket for the build status
[10:30:42.220] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:42.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:83:0) after 1m0s
[10:31:42.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:83:0)
[10:31:42.509] Timer tick, asking Buildbucket for the build status
[10:31:42.686] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:42.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:84:0) after 1m0s
[10:32:42.673] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:84:0)
[10:32:42.673] Timer tick, asking Buildbucket for the build status
[10:32:42.832] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:42.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:85:0) after 1m0s
[10:33:42.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:85:0)
[10:33:42.830] Timer tick, asking Buildbucket for the build status
[10:33:43.016] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:43.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:86:0) after 1m0s
[10:34:43.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:86:0)
[10:34:43.232] Timer tick, asking Buildbucket for the build status
[10:34:43.487] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:87:0) after 1m0s
[10:35:43.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:87:0)
[10:35:43.664] Timer tick, asking Buildbucket for the build status
[10:35:43.876] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:43.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:88:0) after 1m0s
[10:36:43.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:88:0)
[10:36:43.896] Timer tick, asking Buildbucket for the build status
[10:36:44.113] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:44.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:89:0) after 1m0s
[10:37:44.229] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:89:0)
[10:37:44.229] Timer tick, asking Buildbucket for the build status
[10:37:44.412] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:44.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:90:0) after 1m0s
[10:38:44.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:90:0)
[10:38:44.479] Timer tick, asking Buildbucket for the build status
[10:38:44.904] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:44.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:91:0) after 1m0s
[10:39:44.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:91:0)
[10:39:44.953] Timer tick, asking Buildbucket for the build status
[10:39:45.102] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:45.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:92:0) after 1m0s
[10:40:45.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:92:0)
[10:40:45.256] Timer tick, asking Buildbucket for the build status
[10:40:45.693] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:45.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:93:0) after 1m0s
[10:41:45.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:93:0)
[10:41:45.716] Timer tick, asking Buildbucket for the build status
[10:41:45.979] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:45.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:94:0) after 1m0s
[10:42:46.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:94:0)
[10:42:46.084] Timer tick, asking Buildbucket for the build status
[10:42:46.267] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:46.267] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:95:0) after 1m0s
[10:43:46.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:95:0)
[10:43:46.292] Timer tick, asking Buildbucket for the build status
[10:43:47.116] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:47.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:96:0) after 1m0s
[10:44:47.160] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:96:0)
[10:44:47.160] Timer tick, asking Buildbucket for the build status
[10:44:47.347] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:97:0) after 1m0s
[10:45:47.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:97:0)
[10:45:47.390] Timer tick, asking Buildbucket for the build status
[10:45:47.622] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:47.622] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:98:0) after 1m0s
[10:46:47.644] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:98:0)
[10:46:47.644] Timer tick, asking Buildbucket for the build status
[10:46:47.907] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:47.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:99:0) after 1m0s
[10:47:47.973] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:99:0)
[10:47:47.973] Timer tick, asking Buildbucket for the build status
[10:47:48.314] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:48.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:100:0) after 1m0s
[10:48:48.376] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:100:0)
[10:48:48.376] Timer tick, asking Buildbucket for the build status
[10:48:48.970] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:48.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:101:0) after 1m0s
[10:49:49.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:101:0)
[10:49:49.071] Timer tick, asking Buildbucket for the build status
[10:49:49.296] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:49.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:102:0) after 1m0s
[10:50:49.381] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:102:0)
[10:50:49.381] Timer tick, asking Buildbucket for the build status
[10:50:49.574] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:49.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:103:0) after 1m0s
[10:51:49.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:103:0)
[10:51:49.580] Timer tick, asking Buildbucket for the build status
[10:51:49.746] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:49.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:104:0) after 1m0s
[10:52:49.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:104:0)
[10:52:49.851] Timer tick, asking Buildbucket for the build status
[10:52:50.421] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:50.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:105:0) after 1m0s
[10:53:50.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:105:0)
[10:53:50.477] Timer tick, asking Buildbucket for the build status
[10:53:50.673] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:50.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:106:0) after 1m0s
[10:54:50.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:106:0)
[10:54:50.730] Timer tick, asking Buildbucket for the build status
[10:54:51.122] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:51.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:107:0) after 1m0s
[10:55:51.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:107:0)
[10:55:51.151] Timer tick, asking Buildbucket for the build status
[10:55:51.325] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:51.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:108:0) after 1m0s
[10:56:51.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:108:0)
[10:56:51.353] Timer tick, asking Buildbucket for the build status
[10:56:52.438] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:52.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:109:0) after 1m0s
[10:57:52.467] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:109:0)
[10:57:52.467] Timer tick, asking Buildbucket for the build status
[10:57:52.881] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:52.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:110:0) after 1m0s
[10:58:52.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:110:0)
[10:58:52.944] Timer tick, asking Buildbucket for the build status
[10:58:53.142] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:53.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:111:0) after 1m0s
[10:59:53.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:111:0)
[10:59:53.165] Timer tick, asking Buildbucket for the build status
[10:59:53.392] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:53.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:112:0) after 1m0s
[11:00:53.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:112:0)
[11:00:53.444] Timer tick, asking Buildbucket for the build status
[11:00:54.470] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:54.471] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:113:0) after 1m0s
[11:01:54.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:113:0)
[11:01:54.538] Timer tick, asking Buildbucket for the build status
[11:01:54.705] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:54.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:114:0) after 1m0s
[11:02:54.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:114:0)
[11:02:54.700] Timer tick, asking Buildbucket for the build status
[11:02:54.856] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:54.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:115:0) after 1m0s
[11:03:54.974] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:115:0)
[11:03:54.974] Timer tick, asking Buildbucket for the build status
[11:03:55.185] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:55.185] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:116:0) after 1m0s
[11:04:55.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:116:0)
[11:04:55.277] Timer tick, asking Buildbucket for the build status
[11:04:55.617] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:55.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:117:0) after 1m0s
[11:05:55.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:117:0)
[11:05:55.643] Timer tick, asking Buildbucket for the build status
[11:05:55.825] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:55.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:118:0) after 1m0s
[11:06:55.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:118:0)
[11:06:55.853] Timer tick, asking Buildbucket for the build status
[11:06:55.973] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:55.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:119:0) after 1m0s
[11:07:56.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:119:0)
[11:07:56.019] Timer tick, asking Buildbucket for the build status
[11:07:56.390] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:56.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:120:0) after 1m0s
[11:08:56.469] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:120:0)
[11:08:56.469] Timer tick, asking Buildbucket for the build status
[11:08:56.718] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:56.718] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:121:0) after 1m0s
[11:09:56.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:121:0)
[11:09:56.848] Timer tick, asking Buildbucket for the build status
[11:09:58.311] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:58.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:122:0) after 1m0s
[11:10:58.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:122:0)
[11:10:58.310] Timer tick, asking Buildbucket for the build status
[11:10:59.316] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:59.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:123:0) after 1m0s
[11:11:59.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:123:0)
[11:11:59.339] Timer tick, asking Buildbucket for the build status
[11:11:59.503] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:59.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:124:0) after 1m0s
[11:12:59.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:124:0)
[11:12:59.516] Timer tick, asking Buildbucket for the build status
[11:13:00.698] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:00.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:125:0) after 1m0s
[11:14:00.747] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:125:0)
[11:14:00.747] Timer tick, asking Buildbucket for the build status
[11:14:00.962] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:00.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:126:0) after 1m0s
[11:15:00.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:126:0)
[11:15:00.991] Timer tick, asking Buildbucket for the build status
[11:15:01.459] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:01.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:127:0) after 1m0s
[11:16:01.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:127:0)
[11:16:01.550] Timer tick, asking Buildbucket for the build status
[11:16:01.895] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:01.895] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:128:0) after 1m0s
[11:17:01.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:128:0)
[11:17:01.955] Timer tick, asking Buildbucket for the build status
[11:17:02.121] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:02.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:129:0) after 1m0s
[11:18:02.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:129:0)
[11:18:02.154] Timer tick, asking Buildbucket for the build status
[11:18:02.648] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:02.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:130:0) after 1m0s
[11:19:02.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:130:0)
[11:19:02.752] Timer tick, asking Buildbucket for the build status
[11:19:02.977] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:02.977] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:131:0) after 1m0s
[11:20:03.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:131:0)
[11:20:03.009] Timer tick, asking Buildbucket for the build status
[11:20:03.183] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:03.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:132:0) after 1m0s
[11:21:03.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:132:0)
[11:21:03.295] Timer tick, asking Buildbucket for the build status
[11:21:03.946] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:03.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:133:0) after 1m0s
[11:22:03.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:133:0)
[11:22:03.992] Timer tick, asking Buildbucket for the build status
[11:22:04.214] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:04.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:134:0) after 1m0s
[11:23:04.383] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:134:0)
[11:23:04.383] Timer tick, asking Buildbucket for the build status
[11:23:05.022] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:05.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:135:0) after 1m0s
[11:24:05.088] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:135:0)
[11:24:05.088] Timer tick, asking Buildbucket for the build status
[11:24:05.691] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:05.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:136:0) after 1m0s
[11:25:05.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:136:0)
[11:25:05.716] Timer tick, asking Buildbucket for the build status
[11:25:05.876] Build 8889306416651793808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:05.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054736478683246880:137:0) after 1m0s
[11:25:24.058] Received PubSub notification, asking Buildbucket for the build status
[11:25:24.198] Build 8889306416651793808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:25:24.198] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580901923211051",
"created_by": "project:chromium",
"created_ts": "1580893801981771",
"id": "8889306416651793808",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1cb0d64a30282f19d8592bb3f6855274830dbad7\"}}",
"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-east1-d-8-13-kp6l\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26713, \"got_angle_revision\": \"f764fc02e94c620b19beb761c610972f1d254591\", \"got_dawn_revision\": \"47b15048a1fab6c360dc1594764506224655752b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"1cb0d64a30282f19d8592bb3f6855274830dbad7\", \"got_revision_cp\": \"refs/heads/master@{#738493}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8e8e1d0dd7292440b803b95bc0832589520f784d\", \"got_v8_revision\": \"30fcb3ebe01452448273e5fe198141107973b5fd\", \"got_v8_revision_cp\": \"refs/heads/8.2.11@{#1}\", \"got_webrtc_revision\": \"0f6bcd18b2ef109850c6430fa0d474688571da5f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30455}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1cb0d64a30282f19d8592bb3f6855274830dbad7\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2b25d58305a6755482534765a65f2521477c19af0731994631a8cf25b9f3b571_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_91dc5ce0f7d9a4ba8efbdbb6360d947a001f2754e92adddaf9400582bbdcce50_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_ce52aa3ab9d9a450d9b5f3fb151dc5a055ee991845b7d9f6a360be4cd1eb07f1_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-east1-d-8-13-kp6l\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4809-bb2013c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580894101744417",
"status": "COMPLETED",
"status_changed_ts": "1580901923579814",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26713",
"builder:Deterministic Linux",
"buildset:commit/git/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1cb0d64a30282f19d8592bb3f6855274830dbad7",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054736478683246880",
"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/8889306416651793808/+/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:4a2d6e9938809410",
"user_agent:luci-scheduler"
],
"updated_ts": "1580901923645463",
"url": "https://ci.chromium.org/b/8889306416651793808",
"utcnow_ts": "1580901924187059"
}
}
[11:25:24.198] Invocation finished in 2h15m23.536742812s with status SUCCEEDED