[19:49:34.539] New invocation is queued and will start shortly
[19:49:35.667] Starting the invocation (attempt 1)
[19:49:35.784] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:49:35.784] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:49:35.784] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070641306895186256",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f60748f4ac326781100987dc9f40a1e010586785\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9070641306895186256",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/f60748f4ac326781100987dc9f40a1e010586785",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f60748f4ac326781100987dc9f40a1e010586785",
"gitiles_ref:refs/heads/master"
]
}
[19:49:37.254] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565725776067648",
"id": "8905211244592870576",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f60748f4ac326781100987dc9f40a1e010586785\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565725776807192",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24383",
"builder:Deterministic Linux",
"buildset:commit/git/f60748f4ac326781100987dc9f40a1e010586785",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f60748f4ac326781100987dc9f40a1e010586785",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070641306895186256",
"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/8905211244592870576/+/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": "1565725776807296",
"url": "https://ci.chromium.org/b/8905211244592870576",
"utcnow_ts": "1565725777221118"
}
}
[19:49:37.254] Task URL: https://ci.chromium.org/b/8905211244592870576
[19:49:37.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:2:0) after 1m0s
[19:49:45.904] Received PubSub notification, asking Buildbucket for the build status
[19:49:46.286] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:37.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:2:0)
[19:50:37.296] Timer tick, asking Buildbucket for the build status
[19:50:38.035] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:38.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:4:0) after 1m0s
[19:51:38.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:4:0)
[19:51:38.122] Timer tick, asking Buildbucket for the build status
[19:51:38.377] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:5:0) after 1m0s
[19:52:38.448] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:5:0)
[19:52:38.448] Timer tick, asking Buildbucket for the build status
[19:52:38.716] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:38.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:6:0) after 1m0s
[19:53:38.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:6:0)
[19:53:38.827] Timer tick, asking Buildbucket for the build status
[19:53:39.014] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:39.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:7:0) after 1m0s
[19:54:39.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:7:0)
[19:54:39.052] Timer tick, asking Buildbucket for the build status
[19:54:39.252] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:39.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:8:0) after 1m0s
[19:55:39.292] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:8:0)
[19:55:39.292] Timer tick, asking Buildbucket for the build status
[19:55:39.506] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:39.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:9:0) after 1m0s
[19:56:39.541] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:9:0)
[19:56:39.541] Timer tick, asking Buildbucket for the build status
[19:56:39.723] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:39.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:10:0) after 1m0s
[19:57:39.775] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:10:0)
[19:57:39.775] Timer tick, asking Buildbucket for the build status
[19:57:40.072] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:40.072] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:11:0) after 1m0s
[19:58:40.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:11:0)
[19:58:40.320] Timer tick, asking Buildbucket for the build status
[19:58:43.940] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:43.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:12:0) after 1m0s
[19:59:44.030] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:12:0)
[19:59:44.030] Timer tick, asking Buildbucket for the build status
[19:59:44.899] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:44.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:13:0) after 1m0s
[20:00:44.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:13:0)
[20:00:44.934] Timer tick, asking Buildbucket for the build status
[20:00:45.948] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:14:0) after 1m0s
[20:01:46.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:14:0)
[20:01:46.005] Timer tick, asking Buildbucket for the build status
[20:01:46.368] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:46.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:15:0) after 1m0s
[20:02:46.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:15:0)
[20:02:46.435] Timer tick, asking Buildbucket for the build status
[20:02:46.660] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:46.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:16:0) after 1m0s
[20:03:46.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:16:0)
[20:03:46.835] Timer tick, asking Buildbucket for the build status
[20:03:47.045] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:47.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:17:0) after 1m0s
[20:04:47.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:17:0)
[20:04:47.135] Timer tick, asking Buildbucket for the build status
[20:04:47.672] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:47.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:18:0) after 1m0s
[20:05:47.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:18:0)
[20:05:47.825] Timer tick, asking Buildbucket for the build status
[20:05:48.087] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:48.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:19:0) after 1m0s
[20:06:48.303] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:19:0)
[20:06:48.303] Timer tick, asking Buildbucket for the build status
[20:06:49.067] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:20:0) after 1m0s
[20:07:49.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:20:0)
[20:07:49.121] Timer tick, asking Buildbucket for the build status
[20:07:49.781] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:49.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:21:0) after 1m0s
[20:08:49.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:21:0)
[20:08:49.914] Timer tick, asking Buildbucket for the build status
[20:08:50.252] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:50.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:22:0) after 1m0s
[20:09:50.792] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:22:0)
[20:09:50.792] Timer tick, asking Buildbucket for the build status
[20:09:53.071] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:53.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:23:0) after 1m0s
[20:10:53.345] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:23:0)
[20:10:53.345] Timer tick, asking Buildbucket for the build status
[20:10:54.396] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:54.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:24:0) after 1m0s
[20:11:54.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:24:0)
[20:11:54.489] Timer tick, asking Buildbucket for the build status
[20:11:55.400] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:55.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:25:0) after 1m0s
[20:12:55.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:25:0)
[20:12:55.542] Timer tick, asking Buildbucket for the build status
[20:12:55.833] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:55.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:26:0) after 1m0s
[20:13:55.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:26:0)
[20:13:55.946] Timer tick, asking Buildbucket for the build status
[20:13:56.193] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:56.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:27:0) after 1m0s
[20:14:56.318] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:27:0)
[20:14:56.318] Timer tick, asking Buildbucket for the build status
[20:14:56.584] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:56.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:28:0) after 1m0s
[20:15:56.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:28:0)
[20:15:56.787] Timer tick, asking Buildbucket for the build status
[20:15:56.973] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:56.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:29:0) after 1m0s
[20:16:57.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:29:0)
[20:16:57.287] Timer tick, asking Buildbucket for the build status
[20:16:57.503] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:57.503] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:30:0) after 1m0s
[20:17:57.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:30:0)
[20:17:57.531] Timer tick, asking Buildbucket for the build status
[20:17:58.162] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:58.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:31:0) after 1m0s
[20:18:58.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:31:0)
[20:18:58.508] Timer tick, asking Buildbucket for the build status
[20:18:58.955] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:58.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:32:0) after 1m0s
[20:19:59.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:32:0)
[20:19:59.015] Timer tick, asking Buildbucket for the build status
[20:19:59.804] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:59.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:33:0) after 1m0s
[20:20:59.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:33:0)
[20:20:59.896] Timer tick, asking Buildbucket for the build status
[20:21:01.008] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:01.008] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:34:0) after 1m0s
[20:22:01.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:34:0)
[20:22:01.051] Timer tick, asking Buildbucket for the build status
[20:22:02.021] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:02.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:35:0) after 1m0s
[20:23:02.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:35:0)
[20:23:02.124] Timer tick, asking Buildbucket for the build status
[20:23:02.287] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:02.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:36:0) after 1m0s
[20:24:02.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:36:0)
[20:24:02.554] Timer tick, asking Buildbucket for the build status
[20:24:03.127] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:03.127] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:37:0) after 1m0s
[20:25:03.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:37:0)
[20:25:03.271] Timer tick, asking Buildbucket for the build status
[20:25:03.548] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:03.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:38:0) after 1m0s
[20:26:03.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:38:0)
[20:26:03.617] Timer tick, asking Buildbucket for the build status
[20:26:04.710] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:04.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:39:0) after 1m0s
[20:27:04.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:39:0)
[20:27:04.761] Timer tick, asking Buildbucket for the build status
[20:27:05.670] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:05.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:40:0) after 1m0s
[20:28:05.685] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:40:0)
[20:28:05.685] Timer tick, asking Buildbucket for the build status
[20:28:05.883] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:05.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:41:0) after 1m0s
[20:29:05.927] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:41:0)
[20:29:05.927] Timer tick, asking Buildbucket for the build status
[20:29:06.220] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:06.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:42:0) after 1m0s
[20:30:06.359] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:42:0)
[20:30:06.359] Timer tick, asking Buildbucket for the build status
[20:30:07.154] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:07.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:43:0) after 1m0s
[20:31:07.348] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:43:0)
[20:31:07.348] Timer tick, asking Buildbucket for the build status
[20:31:07.537] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:07.537] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:44:0) after 1m0s
[20:32:07.546] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:44:0)
[20:32:07.546] Timer tick, asking Buildbucket for the build status
[20:32:07.883] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:07.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:45:0) after 1m0s
[20:33:07.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:45:0)
[20:33:07.910] Timer tick, asking Buildbucket for the build status
[20:33:09.687] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:09.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:46:0) after 1m0s
[20:34:09.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:46:0)
[20:34:09.777] Timer tick, asking Buildbucket for the build status
[20:34:09.947] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:09.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:47:0) after 1m0s
[20:35:10.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:47:0)
[20:35:10.025] Timer tick, asking Buildbucket for the build status
[20:35:10.529] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:10.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:48:0) after 1m0s
[20:36:10.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:48:0)
[20:36:10.569] Timer tick, asking Buildbucket for the build status
[20:36:11.212] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:11.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:49:0) after 1m0s
[20:37:11.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:49:0)
[20:37:11.245] Timer tick, asking Buildbucket for the build status
[20:37:11.435] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:11.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:50:0) after 1m0s
[20:38:11.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:50:0)
[20:38:11.460] Timer tick, asking Buildbucket for the build status
[20:38:11.661] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:11.661] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:51:0) after 1m0s
[20:39:11.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:51:0)
[20:39:11.866] Timer tick, asking Buildbucket for the build status
[20:39:12.130] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:12.130] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:52:0) after 1m0s
[20:40:12.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:52:0)
[20:40:12.302] Timer tick, asking Buildbucket for the build status
[20:40:12.526] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:12.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:53:0) after 1m0s
[20:41:12.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:53:0)
[20:41:12.635] Timer tick, asking Buildbucket for the build status
[20:41:13.371] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:13.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:54:0) after 1m0s
[20:42:13.589] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:54:0)
[20:42:13.589] Timer tick, asking Buildbucket for the build status
[20:42:14.134] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:14.134] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:55:0) after 1m0s
[20:43:14.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:55:0)
[20:43:14.265] Timer tick, asking Buildbucket for the build status
[20:43:14.710] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:14.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:56:0) after 1m0s
[20:44:14.840] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:56:0)
[20:44:14.840] Timer tick, asking Buildbucket for the build status
[20:44:15.223] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:15.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:57:0) after 1m0s
[20:45:15.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:57:0)
[20:45:15.306] Timer tick, asking Buildbucket for the build status
[20:45:16.381] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:58:0) after 1m0s
[20:46:16.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:58:0)
[20:46:16.487] Timer tick, asking Buildbucket for the build status
[20:46:17.191] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:17.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:59:0) after 1m0s
[20:47:17.255] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:59:0)
[20:47:17.255] Timer tick, asking Buildbucket for the build status
[20:47:17.490] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:17.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:60:0) after 1m0s
[20:48:17.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:60:0)
[20:48:17.568] Timer tick, asking Buildbucket for the build status
[20:48:18.439] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:18.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:61:0) after 1m0s
[20:49:18.730] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:61:0)
[20:49:18.730] Timer tick, asking Buildbucket for the build status
[20:49:19.208] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:19.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:62:0) after 1m0s
[20:50:19.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:62:0)
[20:50:19.252] Timer tick, asking Buildbucket for the build status
[20:50:19.883] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:19.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:63:0) after 1m0s
[20:51:19.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:63:0)
[20:51:19.993] Timer tick, asking Buildbucket for the build status
[20:51:20.479] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:20.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:64:0) after 1m0s
[20:52:20.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:64:0)
[20:52:20.626] Timer tick, asking Buildbucket for the build status
[20:52:25.061] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:25.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:65:0) after 1m0s
[20:53:25.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:65:0)
[20:53:25.205] Timer tick, asking Buildbucket for the build status
[20:53:25.394] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:25.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:66:0) after 1m0s
[20:54:25.506] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:66:0)
[20:54:25.506] Timer tick, asking Buildbucket for the build status
[20:54:25.803] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:25.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:67:0) after 1m0s
[20:55:25.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:67:0)
[20:55:25.881] Timer tick, asking Buildbucket for the build status
[20:55:26.106] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:26.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:68:0) after 1m0s
[20:56:26.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:68:0)
[20:56:26.176] Timer tick, asking Buildbucket for the build status
[20:56:26.513] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:26.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:69:0) after 1m0s
[20:57:26.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:69:0)
[20:57:26.588] Timer tick, asking Buildbucket for the build status
[20:57:27.805] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:70:0) after 1m0s
[20:58:27.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:70:0)
[20:58:27.964] Timer tick, asking Buildbucket for the build status
[20:58:28.530] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:28.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:71:0) after 1m0s
[20:59:28.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:71:0)
[20:59:28.642] Timer tick, asking Buildbucket for the build status
[20:59:28.852] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:28.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:72:0) after 1m0s
[21:00:28.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:72:0)
[21:00:28.995] Timer tick, asking Buildbucket for the build status
[21:00:30.737] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:30.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:73:0) after 1m0s
[21:01:30.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:73:0)
[21:01:30.787] Timer tick, asking Buildbucket for the build status
[21:01:31.515] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:31.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:74:0) after 1m0s
[21:02:31.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:74:0)
[21:02:31.502] Timer tick, asking Buildbucket for the build status
[21:02:32.634] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:32.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:75:0) after 1m0s
[21:03:32.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:75:0)
[21:03:32.707] Timer tick, asking Buildbucket for the build status
[21:03:32.936] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:32.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:76:0) after 1m0s
[21:04:32.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:76:0)
[21:04:32.979] Timer tick, asking Buildbucket for the build status
[21:04:33.192] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:33.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:77:0) after 1m0s
[21:05:33.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:77:0)
[21:05:33.267] Timer tick, asking Buildbucket for the build status
[21:05:35.201] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:35.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:78:0) after 1m0s
[21:06:35.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:78:0)
[21:06:35.276] Timer tick, asking Buildbucket for the build status
[21:06:37.106] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:37.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:79:0) after 1m0s
[21:07:37.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:79:0)
[21:07:37.190] Timer tick, asking Buildbucket for the build status
[21:07:37.386] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:37.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:80:0) after 1m0s
[21:08:37.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:80:0)
[21:08:37.424] Timer tick, asking Buildbucket for the build status
[21:08:37.630] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:37.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:81:0) after 1m0s
[21:09:37.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:81:0)
[21:09:37.657] Timer tick, asking Buildbucket for the build status
[21:09:39.865] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:39.865] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:82:0) after 1m0s
[21:10:39.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:82:0)
[21:10:39.896] Timer tick, asking Buildbucket for the build status
[21:10:40.183] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:40.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:83:0) after 1m0s
[21:11:40.243] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:83:0)
[21:11:40.243] Timer tick, asking Buildbucket for the build status
[21:11:41.141] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:41.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:84:0) after 1m0s
[21:12:41.146] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:84:0)
[21:12:41.146] Timer tick, asking Buildbucket for the build status
[21:12:43.233] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:43.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:85:0) after 1m0s
[21:13:43.340] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:85:0)
[21:13:43.340] Timer tick, asking Buildbucket for the build status
[21:13:43.580] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:43.580] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:86:0) after 1m0s
[21:14:43.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:86:0)
[21:14:43.698] Timer tick, asking Buildbucket for the build status
[21:14:43.914] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:43.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:87:0) after 1m0s
[21:15:43.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:87:0)
[21:15:43.962] Timer tick, asking Buildbucket for the build status
[21:15:44.198] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:44.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:88:0) after 1m0s
[21:16:44.263] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:88:0)
[21:16:44.263] Timer tick, asking Buildbucket for the build status
[21:16:44.482] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:44.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:89:0) after 1m0s
[21:17:44.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:89:0)
[21:17:44.671] Timer tick, asking Buildbucket for the build status
[21:17:45.006] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:45.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:90:0) after 1m0s
[21:18:45.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:90:0)
[21:18:45.052] Timer tick, asking Buildbucket for the build status
[21:18:47.572] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:47.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:91:0) after 1m0s
[21:19:47.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:91:0)
[21:19:47.645] Timer tick, asking Buildbucket for the build status
[21:19:47.894] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:47.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:92:0) after 1m0s
[21:20:48.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:92:0)
[21:20:48.005] Timer tick, asking Buildbucket for the build status
[21:20:48.256] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:48.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:93:0) after 1m0s
[21:21:48.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:93:0)
[21:21:48.364] Timer tick, asking Buildbucket for the build status
[21:21:48.613] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:48.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:94:0) after 1m0s
[21:22:48.857] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:94:0)
[21:22:48.857] Timer tick, asking Buildbucket for the build status
[21:22:49.224] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:49.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:95:0) after 1m0s
[21:23:49.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:95:0)
[21:23:49.331] Timer tick, asking Buildbucket for the build status
[21:23:49.728] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:49.728] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:96:0) after 1m0s
[21:24:49.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:96:0)
[21:24:49.948] Timer tick, asking Buildbucket for the build status
[21:24:50.295] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:50.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:97:0) after 1m0s
[21:25:50.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:97:0)
[21:25:50.444] Timer tick, asking Buildbucket for the build status
[21:25:50.825] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:50.825] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:98:0) after 1m0s
[21:26:51.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:98:0)
[21:26:51.063] Timer tick, asking Buildbucket for the build status
[21:26:52.058] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:52.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:99:0) after 1m0s
[21:27:52.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:99:0)
[21:27:52.201] Timer tick, asking Buildbucket for the build status
[21:27:53.009] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:53.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:100:0) after 1m0s
[21:28:53.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:100:0)
[21:28:53.062] Timer tick, asking Buildbucket for the build status
[21:28:54.781] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:54.781] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:101:0) after 1m0s
[21:29:54.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:101:0)
[21:29:54.883] Timer tick, asking Buildbucket for the build status
[21:29:56.717] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:56.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:102:0) after 1m0s
[21:30:56.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:102:0)
[21:30:56.829] Timer tick, asking Buildbucket for the build status
[21:30:58.654] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:58.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:103:0) after 1m0s
[21:31:58.710] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:103:0)
[21:31:58.710] Timer tick, asking Buildbucket for the build status
[21:32:03.928] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:03.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:104:0) after 1m0s
[21:33:03.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:104:0)
[21:33:03.988] Timer tick, asking Buildbucket for the build status
[21:33:04.383] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:04.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:105:0) after 1m0s
[21:34:04.466] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:105:0)
[21:34:04.466] Timer tick, asking Buildbucket for the build status
[21:34:04.736] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:04.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:106:0) after 1m0s
[21:35:04.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:106:0)
[21:35:04.808] Timer tick, asking Buildbucket for the build status
[21:35:05.208] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:05.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:107:0) after 1m0s
[21:36:05.238] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:107:0)
[21:36:05.238] Timer tick, asking Buildbucket for the build status
[21:36:06.162] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:06.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:108:0) after 1m0s
[21:37:06.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:108:0)
[21:37:06.445] Timer tick, asking Buildbucket for the build status
[21:37:06.779] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:06.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:109:0) after 1m0s
[21:38:06.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:109:0)
[21:38:06.810] Timer tick, asking Buildbucket for the build status
[21:38:07.221] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:07.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:110:0) after 1m0s
[21:39:07.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:110:0)
[21:39:07.311] Timer tick, asking Buildbucket for the build status
[21:39:07.527] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:07.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:111:0) after 1m0s
[21:40:07.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:111:0)
[21:40:07.550] Timer tick, asking Buildbucket for the build status
[21:40:07.843] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:07.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:112:0) after 1m0s
[21:41:07.892] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:112:0)
[21:41:07.892] Timer tick, asking Buildbucket for the build status
[21:41:08.175] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:08.175] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:113:0) after 1m0s
[21:42:08.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:113:0)
[21:42:08.285] Timer tick, asking Buildbucket for the build status
[21:42:11.152] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:11.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:114:0) after 1m0s
[21:43:11.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:114:0)
[21:43:11.239] Timer tick, asking Buildbucket for the build status
[21:43:12.141] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:12.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:115:0) after 1m0s
[21:44:12.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:115:0)
[21:44:12.156] Timer tick, asking Buildbucket for the build status
[21:44:14.445] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:14.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:116:0) after 1m0s
[21:45:14.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:116:0)
[21:45:14.493] Timer tick, asking Buildbucket for the build status
[21:45:14.680] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:14.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:117:0) after 1m0s
[21:46:14.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:117:0)
[21:46:14.749] Timer tick, asking Buildbucket for the build status
[21:46:15.461] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:15.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:118:0) after 1m0s
[21:47:15.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:118:0)
[21:47:15.509] Timer tick, asking Buildbucket for the build status
[21:47:16.217] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:16.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:119:0) after 1m0s
[21:48:16.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:119:0)
[21:48:16.327] Timer tick, asking Buildbucket for the build status
[21:48:17.992] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:17.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:120:0) after 1m0s
[21:49:18.019] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:120:0)
[21:49:18.019] Timer tick, asking Buildbucket for the build status
[21:49:19.520] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:19.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:121:0) after 1m0s
[21:50:19.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:121:0)
[21:50:19.617] Timer tick, asking Buildbucket for the build status
[21:50:20.133] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:20.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:122:0) after 1m0s
[21:51:20.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:122:0)
[21:51:20.247] Timer tick, asking Buildbucket for the build status
[21:51:21.151] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:21.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:123:0) after 1m0s
[21:52:21.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:123:0)
[21:52:21.269] Timer tick, asking Buildbucket for the build status
[21:52:22.027] Build 8905211244592870576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:22.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9070641306895186256:124:0) after 1m0s
[21:53:04.671] Received PubSub notification, asking Buildbucket for the build status
[21:53:05.150] Build 8905211244592870576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:53:05.150] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565733183682195",
"created_by": "project:chromium",
"created_ts": "1565725776067648",
"id": "8905211244592870576",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f60748f4ac326781100987dc9f40a1e010586785\"}}",
"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-xenial-us-east1-d-8-27-a29f\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 24383, \"got_angle_revision\": \"956770025c8ca163847b5c21da596f07d024d1dd\", \"got_dawn_revision\": \"b6d7c537088835c386bc7850d85300f9f72d4cf6\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"f60748f4ac326781100987dc9f40a1e010586785\", \"got_revision_cp\": \"refs/heads/master@{#686519}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"83ed30595d74cd1ea3f4396984df34e8987669cc\", \"got_v8_revision_cp\": \"refs/heads/7.8.99@{#1}\", \"got_webrtc_revision\": \"34aee67c11454e6c20c1a48702e92b48062cd2bf\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28839}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f60748f4ac326781100987dc9f40a1e010586785\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_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-xenial-us-east1-d-8-27-a29f\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"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\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565725784650445",
"status": "COMPLETED",
"status_changed_ts": "1565733183999461",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24383",
"builder:Deterministic Linux",
"buildset:commit/git/f60748f4ac326781100987dc9f40a1e010586785",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f60748f4ac326781100987dc9f40a1e010586785",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070641306895186256",
"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/8905211244592870576/+/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:46a558e584799c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1565733184005704",
"url": "https://ci.chromium.org/b/8905211244592870576",
"utcnow_ts": "1565733185136103"
}
}
[21:53:05.150] Invocation finished in 2h3m30.661225276s with status SUCCEEDED