[23:46:39.188] New invocation is queued and will start shortly
[23:46:40.282] Starting the invocation (attempt 1)
[23:46:40.322] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:46:40.323] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:46:40.323] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9054681325148728704",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5068d53694c51192af3b7b7518477ceeff52df02\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9054681325148728704",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/5068d53694c51192af3b7b7518477ceeff52df02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5068d53694c51192af3b7b7518477ceeff52df02",
"gitiles_ref:refs/heads/master"
]
}
[23:46:41.322] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1580946400550796",
"id": "8889251263055322912",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5068d53694c51192af3b7b7518477ceeff52df02\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1580946400980301",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26720",
"builder:Deterministic Linux",
"buildset:commit/git/5068d53694c51192af3b7b7518477ceeff52df02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5068d53694c51192af3b7b7518477ceeff52df02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054681325148728704",
"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/8889251263055322912/+/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": "1580946400980465",
"url": "https://ci.chromium.org/b/8889251263055322912",
"utcnow_ts": "1580946401306957"
}
}
[23:46:41.322] Task URL: https://ci.chromium.org/b/8889251263055322912
[23:46:41.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:2:0) after 1m0s
[23:47:30.458] Received PubSub notification, asking Buildbucket for the build status
[23:47:31.469] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:41.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:2:0)
[23:47:41.321] Timer tick, asking Buildbucket for the build status
[23:47:41.478] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:41.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:4:0) after 1m0s
[23:48:41.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:4:0)
[23:48:41.471] Timer tick, asking Buildbucket for the build status
[23:48:41.735] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:41.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:5:0) after 1m0s
[23:49:41.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:5:0)
[23:49:41.824] Timer tick, asking Buildbucket for the build status
[23:49:42.338] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:42.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:6:0) after 1m0s
[23:50:42.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:6:0)
[23:50:42.384] Timer tick, asking Buildbucket for the build status
[23:50:43.183] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:43.183] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:7:0) after 1m0s
[23:51:43.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:7:0)
[23:51:43.220] Timer tick, asking Buildbucket for the build status
[23:51:43.476] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:43.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:8:0) after 1m0s
[23:52:43.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:8:0)
[23:52:43.495] Timer tick, asking Buildbucket for the build status
[23:52:43.649] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:43.649] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:9:0) after 1m0s
[23:53:43.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:9:0)
[23:53:43.668] Timer tick, asking Buildbucket for the build status
[23:53:43.817] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:43.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:10:0) after 1m0s
[23:54:43.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:10:0)
[23:54:43.872] Timer tick, asking Buildbucket for the build status
[23:54:44.660] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:44.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:11:0) after 1m0s
[23:55:44.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:11:0)
[23:55:44.700] Timer tick, asking Buildbucket for the build status
[23:55:44.888] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:44.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:12:0) after 1m0s
[23:56:44.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:12:0)
[23:56:44.971] Timer tick, asking Buildbucket for the build status
[23:56:45.902] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:45.902] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:13:0) after 1m0s
[23:57:45.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:13:0)
[23:57:45.948] Timer tick, asking Buildbucket for the build status
[23:57:46.276] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:46.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:14:0) after 1m0s
[23:58:46.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:14:0)
[23:58:46.507] Timer tick, asking Buildbucket for the build status
[23:58:46.712] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:46.712] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:15:0) after 1m0s
[23:59:46.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:15:0)
[23:59:46.914] Timer tick, asking Buildbucket for the build status
[23:59:47.091] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:47.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:16:0) after 1m0s
[00:00:47.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:16:0)
[00:00:47.220] Timer tick, asking Buildbucket for the build status
[00:00:47.502] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:47.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:17:0) after 1m0s
[00:01:47.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:17:0)
[00:01:47.513] Timer tick, asking Buildbucket for the build status
[00:01:47.794] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:47.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:18:0) after 1m0s
[00:02:48.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:18:0)
[00:02:48.199] Timer tick, asking Buildbucket for the build status
[00:02:48.669] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:48.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:19:0) after 1m0s
[00:03:48.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:19:0)
[00:03:48.946] Timer tick, asking Buildbucket for the build status
[00:03:49.162] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:49.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:20:0) after 1m0s
[00:04:49.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:20:0)
[00:04:49.449] Timer tick, asking Buildbucket for the build status
[00:04:51.571] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:51.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:21:0) after 1m0s
[00:05:51.706] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:21:0)
[00:05:51.706] Timer tick, asking Buildbucket for the build status
[00:05:51.889] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:51.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:22:0) after 1m0s
[00:06:52.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:22:0)
[00:06:52.413] Timer tick, asking Buildbucket for the build status
[00:06:52.621] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:52.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:23:0) after 1m0s
[00:07:52.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:23:0)
[00:07:52.696] Timer tick, asking Buildbucket for the build status
[00:07:52.900] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:52.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:24:0) after 1m0s
[00:08:53.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:24:0)
[00:08:53.198] Timer tick, asking Buildbucket for the build status
[00:08:53.843] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:53.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:25:0) after 1m0s
[00:09:53.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:25:0)
[00:09:53.987] Timer tick, asking Buildbucket for the build status
[00:09:54.207] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:54.207] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:26:0) after 1m0s
[00:10:54.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:26:0)
[00:10:54.382] Timer tick, asking Buildbucket for the build status
[00:10:54.551] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:54.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:27:0) after 1m0s
[00:11:54.635] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:27:0)
[00:11:54.635] Timer tick, asking Buildbucket for the build status
[00:11:54.901] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:54.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:28:0) after 1m0s
[00:12:54.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:28:0)
[00:12:54.964] Timer tick, asking Buildbucket for the build status
[00:12:55.755] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:55.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:29:0) after 1m0s
[00:13:55.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:29:0)
[00:13:55.838] Timer tick, asking Buildbucket for the build status
[00:13:56.029] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:56.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:30:0) after 1m0s
[00:14:56.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:30:0)
[00:14:56.128] Timer tick, asking Buildbucket for the build status
[00:14:56.403] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:56.403] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:31:0) after 1m0s
[00:15:56.551] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:31:0)
[00:15:56.551] Timer tick, asking Buildbucket for the build status
[00:15:56.938] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:56.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:32:0) after 1m0s
[00:16:57.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:32:0)
[00:16:57.285] Timer tick, asking Buildbucket for the build status
[00:16:57.748] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:57.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:33:0) after 1m0s
[00:17:57.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:33:0)
[00:17:57.912] Timer tick, asking Buildbucket for the build status
[00:17:58.105] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:58.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:34:0) after 1m0s
[00:18:58.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:34:0)
[00:18:58.162] Timer tick, asking Buildbucket for the build status
[00:18:58.366] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:58.366] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:35:0) after 1m0s
[00:19:58.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:35:0)
[00:19:58.468] Timer tick, asking Buildbucket for the build status
[00:19:58.634] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:58.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:36:0) after 1m0s
[00:20:58.721] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:36:0)
[00:20:58.721] Timer tick, asking Buildbucket for the build status
[00:20:58.905] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:58.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:37:0) after 1m0s
[00:21:58.994] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:37:0)
[00:21:58.994] Timer tick, asking Buildbucket for the build status
[00:21:59.192] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:59.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:38:0) after 1m0s
[00:22:59.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:38:0)
[00:22:59.288] Timer tick, asking Buildbucket for the build status
[00:22:59.688] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:59.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:39:0) after 1m0s
[00:23:59.732] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:39:0)
[00:23:59.732] Timer tick, asking Buildbucket for the build status
[00:23:59.871] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:59.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:40:0) after 1m0s
[00:24:59.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:40:0)
[00:24:59.895] Timer tick, asking Buildbucket for the build status
[00:25:00.091] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:00.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:41:0) after 1m0s
[00:26:00.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:41:0)
[00:26:00.193] Timer tick, asking Buildbucket for the build status
[00:26:00.360] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:00.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:42:0) after 1m0s
[00:27:00.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:42:0)
[00:27:00.563] Timer tick, asking Buildbucket for the build status
[00:27:01.204] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:01.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:43:0) after 1m0s
[00:28:01.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:43:0)
[00:28:01.242] Timer tick, asking Buildbucket for the build status
[00:28:01.425] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:01.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:44:0) after 1m0s
[00:29:01.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:44:0)
[00:29:01.595] Timer tick, asking Buildbucket for the build status
[00:29:01.743] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:01.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:45:0) after 1m0s
[00:30:02.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:45:0)
[00:30:02.082] Timer tick, asking Buildbucket for the build status
[00:30:02.272] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:02.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:46:0) after 1m0s
[00:31:02.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:46:0)
[00:31:02.454] Timer tick, asking Buildbucket for the build status
[00:31:02.638] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:02.638] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:47:0) after 1m0s
[00:32:02.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:47:0)
[00:32:02.848] Timer tick, asking Buildbucket for the build status
[00:32:03.104] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:03.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:48:0) after 1m0s
[00:33:03.289] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:48:0)
[00:33:03.289] Timer tick, asking Buildbucket for the build status
[00:33:03.465] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:03.465] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:49:0) after 1m0s
[00:34:03.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:49:0)
[00:34:03.547] Timer tick, asking Buildbucket for the build status
[00:34:03.724] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:03.724] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:50:0) after 1m0s
[00:35:03.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:50:0)
[00:35:03.801] Timer tick, asking Buildbucket for the build status
[00:35:04.611] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:04.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:51:0) after 1m0s
[00:36:04.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:51:0)
[00:36:04.658] Timer tick, asking Buildbucket for the build status
[00:36:04.854] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:04.854] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:52:0) after 1m0s
[00:37:04.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:52:0)
[00:37:04.965] Timer tick, asking Buildbucket for the build status
[00:37:05.118] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:05.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:53:0) after 1m0s
[00:38:05.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:53:0)
[00:38:05.178] Timer tick, asking Buildbucket for the build status
[00:38:05.419] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:05.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:54:0) after 1m0s
[00:39:05.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:54:0)
[00:39:05.722] Timer tick, asking Buildbucket for the build status
[00:39:06.238] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:06.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:55:0) after 1m0s
[00:40:06.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:55:0)
[00:40:06.322] Timer tick, asking Buildbucket for the build status
[00:40:06.511] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:06.511] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:56:0) after 1m0s
[00:41:06.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:56:0)
[00:41:06.665] Timer tick, asking Buildbucket for the build status
[00:41:06.830] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:06.830] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:57:0) after 1m0s
[00:42:06.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:57:0)
[00:42:06.884] Timer tick, asking Buildbucket for the build status
[00:42:08.349] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:08.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:58:0) after 1m0s
[00:43:08.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:58:0)
[00:43:08.429] Timer tick, asking Buildbucket for the build status
[00:43:09.029] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:09.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:59:0) after 1m0s
[00:44:09.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:59:0)
[00:44:09.131] Timer tick, asking Buildbucket for the build status
[00:44:09.374] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:09.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:60:0) after 1m0s
[00:45:09.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:60:0)
[00:45:09.355] Timer tick, asking Buildbucket for the build status
[00:45:09.740] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:09.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:61:0) after 1m0s
[00:46:09.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:61:0)
[00:46:09.786] Timer tick, asking Buildbucket for the build status
[00:46:10.135] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:10.135] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:62:0) after 1m0s
[00:47:10.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:62:0)
[00:47:10.176] Timer tick, asking Buildbucket for the build status
[00:47:10.692] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:10.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:63:0) after 1m0s
[00:48:10.683] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:63:0)
[00:48:10.683] Timer tick, asking Buildbucket for the build status
[00:48:10.862] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:10.862] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:64:0) after 1m0s
[00:49:10.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:64:0)
[00:49:10.879] Timer tick, asking Buildbucket for the build status
[00:49:11.071] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:11.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:65:0) after 1m0s
[00:50:11.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:65:0)
[00:50:11.132] Timer tick, asking Buildbucket for the build status
[00:50:11.607] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:11.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:66:0) after 1m0s
[00:51:11.746] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:66:0)
[00:51:11.746] Timer tick, asking Buildbucket for the build status
[00:51:13.562] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:13.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:67:0) after 1m0s
[00:52:13.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:67:0)
[00:52:13.593] Timer tick, asking Buildbucket for the build status
[00:52:13.780] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:13.780] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:68:0) after 1m0s
[00:53:13.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:68:0)
[00:53:13.835] Timer tick, asking Buildbucket for the build status
[00:53:14.031] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:14.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:69:0) after 1m0s
[00:54:14.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:69:0)
[00:54:14.012] Timer tick, asking Buildbucket for the build status
[00:54:14.377] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:14.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:70:0) after 1m0s
[00:55:14.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:70:0)
[00:55:14.382] Timer tick, asking Buildbucket for the build status
[00:55:14.618] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:14.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:71:0) after 1m0s
[00:56:14.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:71:0)
[00:56:14.663] Timer tick, asking Buildbucket for the build status
[00:56:14.880] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:14.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:72:0) after 1m0s
[00:57:14.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:72:0)
[00:57:14.928] Timer tick, asking Buildbucket for the build status
[00:57:17.351] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:17.351] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:73:0) after 1m0s
[00:58:17.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:73:0)
[00:58:17.444] Timer tick, asking Buildbucket for the build status
[00:58:17.676] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:17.676] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:74:0) after 1m0s
[00:59:17.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:74:0)
[00:59:17.709] Timer tick, asking Buildbucket for the build status
[00:59:17.913] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:75:0) after 1m0s
[01:00:17.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:75:0)
[01:00:17.937] Timer tick, asking Buildbucket for the build status
[01:00:18.283] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:18.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:76:0) after 1m0s
[01:01:18.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:76:0)
[01:01:18.355] Timer tick, asking Buildbucket for the build status
[01:01:18.524] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:18.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:77:0) after 1m0s
[01:02:18.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:77:0)
[01:02:18.552] Timer tick, asking Buildbucket for the build status
[01:02:18.905] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:18.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:78:0) after 1m0s
[01:03:19.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:78:0)
[01:03:19.272] Timer tick, asking Buildbucket for the build status
[01:03:19.654] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:19.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:79:0) after 1m0s
[01:04:19.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:79:0)
[01:04:19.887] Timer tick, asking Buildbucket for the build status
[01:04:20.058] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:20.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:80:0) after 1m0s
[01:05:20.061] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:80:0)
[01:05:20.061] Timer tick, asking Buildbucket for the build status
[01:05:20.220] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:20.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:81:0) after 1m0s
[01:06:20.379] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:81:0)
[01:06:20.379] Timer tick, asking Buildbucket for the build status
[01:06:20.983] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:20.983] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:82:0) after 1m0s
[01:07:21.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:82:0)
[01:07:21.046] Timer tick, asking Buildbucket for the build status
[01:07:21.294] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:21.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:83:0) after 1m0s
[01:08:21.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:83:0)
[01:08:21.556] Timer tick, asking Buildbucket for the build status
[01:08:21.905] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:21.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:84:0) after 1m0s
[01:09:21.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:84:0)
[01:09:21.957] Timer tick, asking Buildbucket for the build status
[01:09:22.158] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:22.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:85:0) after 1m0s
[01:10:22.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:85:0)
[01:10:22.199] Timer tick, asking Buildbucket for the build status
[01:10:22.659] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:22.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:86:0) after 1m0s
[01:11:22.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:86:0)
[01:11:22.728] Timer tick, asking Buildbucket for the build status
[01:11:23.597] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:23.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:87:0) after 1m0s
[01:12:23.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:87:0)
[01:12:23.665] Timer tick, asking Buildbucket for the build status
[01:12:23.842] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:23.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:88:0) after 1m0s
[01:13:23.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:88:0)
[01:13:23.929] Timer tick, asking Buildbucket for the build status
[01:13:24.073] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:24.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:89:0) after 1m0s
[01:14:24.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:89:0)
[01:14:24.104] Timer tick, asking Buildbucket for the build status
[01:14:24.306] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:90:0) after 1m0s
[01:15:24.370] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:90:0)
[01:15:24.370] Timer tick, asking Buildbucket for the build status
[01:15:24.571] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:24.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:91:0) after 1m0s
[01:16:24.669] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:91:0)
[01:16:24.669] Timer tick, asking Buildbucket for the build status
[01:16:25.521] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:25.521] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:92:0) after 1m0s
[01:17:25.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:92:0)
[01:17:25.621] Timer tick, asking Buildbucket for the build status
[01:17:27.147] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:27.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:93:0) after 1m0s
[01:18:27.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:93:0)
[01:18:27.169] Timer tick, asking Buildbucket for the build status
[01:18:27.352] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:27.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:94:0) after 1m0s
[01:19:27.357] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:94:0)
[01:19:27.357] Timer tick, asking Buildbucket for the build status
[01:19:27.615] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:27.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:95:0) after 1m0s
[01:20:27.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:95:0)
[01:20:27.630] Timer tick, asking Buildbucket for the build status
[01:20:27.802] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:27.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:96:0) after 1m0s
[01:21:27.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:96:0)
[01:21:27.829] Timer tick, asking Buildbucket for the build status
[01:21:28.243] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:28.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:97:0) after 1m0s
[01:22:28.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:97:0)
[01:22:28.319] Timer tick, asking Buildbucket for the build status
[01:22:28.822] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:28.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:98:0) after 1m0s
[01:23:28.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:98:0)
[01:23:28.884] Timer tick, asking Buildbucket for the build status
[01:23:29.112] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:29.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:99:0) after 1m0s
[01:24:29.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:99:0)
[01:24:29.170] Timer tick, asking Buildbucket for the build status
[01:24:29.604] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:29.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:100:0) after 1m0s
[01:25:29.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:100:0)
[01:25:29.606] Timer tick, asking Buildbucket for the build status
[01:25:29.829] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:29.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:101:0) after 1m0s
[01:26:30.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:101:0)
[01:26:30.089] Timer tick, asking Buildbucket for the build status
[01:26:30.244] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:30.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:102:0) after 1m0s
[01:27:30.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:102:0)
[01:27:30.418] Timer tick, asking Buildbucket for the build status
[01:27:30.588] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:30.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:103:0) after 1m0s
[01:28:30.758] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:103:0)
[01:28:30.758] Timer tick, asking Buildbucket for the build status
[01:28:31.426] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:31.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:104:0) after 1m0s
[01:29:31.488] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:104:0)
[01:29:31.488] Timer tick, asking Buildbucket for the build status
[01:29:31.667] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:31.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:105:0) after 1m0s
[01:30:31.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:105:0)
[01:30:31.740] Timer tick, asking Buildbucket for the build status
[01:30:31.936] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:31.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:106:0) after 1m0s
[01:31:32.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:106:0)
[01:31:32.163] Timer tick, asking Buildbucket for the build status
[01:31:32.716] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:32.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:107:0) after 1m0s
[01:32:32.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:107:0)
[01:32:32.766] Timer tick, asking Buildbucket for the build status
[01:32:33.099] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:33.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:108:0) after 1m0s
[01:33:33.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:108:0)
[01:33:33.334] Timer tick, asking Buildbucket for the build status
[01:33:33.615] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:33.615] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:109:0) after 1m0s
[01:34:33.733] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:109:0)
[01:34:33.733] Timer tick, asking Buildbucket for the build status
[01:34:34.287] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:34.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:110:0) after 1m0s
[01:35:34.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:110:0)
[01:35:34.449] Timer tick, asking Buildbucket for the build status
[01:35:34.654] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:34.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:111:0) after 1m0s
[01:36:35.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:111:0)
[01:36:35.069] Timer tick, asking Buildbucket for the build status
[01:36:35.206] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:35.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:112:0) after 1m0s
[01:37:35.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:112:0)
[01:37:35.418] Timer tick, asking Buildbucket for the build status
[01:37:35.655] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:35.655] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:113:0) after 1m0s
[01:38:35.862] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:113:0)
[01:38:35.862] Timer tick, asking Buildbucket for the build status
[01:38:37.003] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:37.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:114:0) after 1m0s
[01:39:37.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:114:0)
[01:39:37.334] Timer tick, asking Buildbucket for the build status
[01:39:38.133] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:38.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:115:0) after 1m0s
[01:40:38.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:115:0)
[01:40:38.246] Timer tick, asking Buildbucket for the build status
[01:40:38.410] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:38.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:116:0) after 1m0s
[01:41:38.593] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:116:0)
[01:41:38.593] Timer tick, asking Buildbucket for the build status
[01:41:38.766] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:38.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:117:0) after 1m0s
[01:42:38.871] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:117:0)
[01:42:38.871] Timer tick, asking Buildbucket for the build status
[01:42:39.188] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:39.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:118:0) after 1m0s
[01:43:39.255] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:118:0)
[01:43:39.255] Timer tick, asking Buildbucket for the build status
[01:43:39.491] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:39.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:119:0) after 1m0s
[01:44:39.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:119:0)
[01:44:39.648] Timer tick, asking Buildbucket for the build status
[01:44:40.872] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:120:0) after 1m0s
[01:45:40.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:120:0)
[01:45:40.958] Timer tick, asking Buildbucket for the build status
[01:45:41.754] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:41.754] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:121:0) after 1m0s
[01:46:41.823] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:121:0)
[01:46:41.823] Timer tick, asking Buildbucket for the build status
[01:46:42.012] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:42.012] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:122:0) after 1m0s
[01:47:42.045] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:122:0)
[01:47:42.045] Timer tick, asking Buildbucket for the build status
[01:47:42.257] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:42.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:123:0) after 1m0s
[01:48:42.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:123:0)
[01:48:42.802] Timer tick, asking Buildbucket for the build status
[01:48:43.479] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:43.479] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:124:0) after 1m0s
[01:49:43.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:124:0)
[01:49:43.557] Timer tick, asking Buildbucket for the build status
[01:49:43.873] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:43.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:125:0) after 1m0s
[01:50:43.982] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:125:0)
[01:50:43.982] Timer tick, asking Buildbucket for the build status
[01:50:44.667] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:44.667] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:126:0) after 1m0s
[01:51:44.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:126:0)
[01:51:44.691] Timer tick, asking Buildbucket for the build status
[01:51:44.916] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:44.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:127:0) after 1m0s
[01:52:44.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:127:0)
[01:52:44.971] Timer tick, asking Buildbucket for the build status
[01:52:45.141] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:45.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:128:0) after 1m0s
[01:53:45.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:128:0)
[01:53:45.145] Timer tick, asking Buildbucket for the build status
[01:53:45.330] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:45.330] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:129:0) after 1m0s
[01:54:45.334] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:129:0)
[01:54:45.334] Timer tick, asking Buildbucket for the build status
[01:54:45.500] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:45.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:130:0) after 1m0s
[01:55:45.538] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:130:0)
[01:55:45.538] Timer tick, asking Buildbucket for the build status
[01:55:45.709] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:45.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:131:0) after 1m0s
[01:56:45.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:131:0)
[01:56:45.796] Timer tick, asking Buildbucket for the build status
[01:56:45.986] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:45.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:132:0) after 1m0s
[01:57:46.116] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:132:0)
[01:57:46.116] Timer tick, asking Buildbucket for the build status
[01:57:46.551] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:46.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:133:0) after 1m0s
[01:58:46.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:133:0)
[01:58:46.660] Timer tick, asking Buildbucket for the build status
[01:58:47.020] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:47.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:134:0) after 1m0s
[01:59:47.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:134:0)
[01:59:47.188] Timer tick, asking Buildbucket for the build status
[01:59:47.353] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:47.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:135:0) after 1m0s
[02:00:47.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:135:0)
[02:00:47.634] Timer tick, asking Buildbucket for the build status
[02:00:47.779] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:47.779] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:136:0) after 1m0s
[02:01:47.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:136:0)
[02:01:47.855] Timer tick, asking Buildbucket for the build status
[02:01:48.044] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:48.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:137:0) after 1m0s
[02:02:48.090] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:137:0)
[02:02:48.090] Timer tick, asking Buildbucket for the build status
[02:02:48.378] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:48.378] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:138:0) after 1m0s
[02:03:48.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:138:0)
[02:03:48.479] Timer tick, asking Buildbucket for the build status
[02:03:48.749] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:48.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:139:0) after 1m0s
[02:04:48.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:139:0)
[02:04:48.774] Timer tick, asking Buildbucket for the build status
[02:04:49.149] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:49.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:140:0) after 1m0s
[02:05:49.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:140:0)
[02:05:49.184] Timer tick, asking Buildbucket for the build status
[02:05:49.459] Build 8889251263055322912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:49.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9054681325148728704:141:0) after 1m0s
[02:06:11.166] Received PubSub notification, asking Buildbucket for the build status
[02:06:11.302] Build 8889251263055322912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:06:11.302] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1580954770051524",
"created_by": "project:chromium",
"created_ts": "1580946400550796",
"id": "8889251263055322912",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5068d53694c51192af3b7b7518477ceeff52df02\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-83-5z7b\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26720, \"got_angle_revision\": \"a44d96dcd676fc7d446b41fb766caad9bdab9fda\", \"got_dawn_revision\": \"7fe6efba4ae3388b0cc858b95b4e3755191fc942\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"5068d53694c51192af3b7b7518477ceeff52df02\", \"got_revision_cp\": \"refs/heads/master@{#738735}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"dd48b7e2d06e74e1d20da5f43224b4ae99873e64\", \"got_v8_revision\": \"4dc7c627a1ebc90c34cdb39c44015a83d924f4ee\", \"got_v8_revision_cp\": \"refs/heads/8.2.12@{#1}\", \"got_webrtc_revision\": \"703a5d76d9ba8e7984509cc7bf70fb4ed84ef6be\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30461}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5068d53694c51192af3b7b7518477ceeff52df02\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_65ed874bd033a5984c3cbb528261ef1b136b40627f077f473aaaca27b3fa3caf_v2\", \"builder_69f5bab4a885266166e099964d6d1498f6d3761c92bc1d5b083a29cb822fe90c_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_bdaf1433b62bd3619468ac2d2b745ba32f34c58221b7630e6cf9dedcc4b44d8b_v2\", \"builder_c9091f6bc58db7983401393b6dacc93b3db8fae2c2ae9b40177b9e0904c8bc80_v2\", \"builder_cfdb55a1f65ed072d1fe07f7fc1107a97a5e848a8d1b6b0015401ab521f6b501_v2\", \"builder_f5b4454e99a04aaa5ba743b59cc70de19e20bebedef65e50e3b90534a8d6a5e4_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-83-5z7b\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1580946448801281",
"status": "COMPLETED",
"status_changed_ts": "1580954770431259",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26720",
"builder:Deterministic Linux",
"buildset:commit/git/5068d53694c51192af3b7b7518477ceeff52df02",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5068d53694c51192af3b7b7518477ceeff52df02",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9054681325148728704",
"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/8889251263055322912/+/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:4a3091304d1f4010",
"user_agent:luci-scheduler"
],
"updated_ts": "1580954770438805",
"url": "https://ci.chromium.org/b/8889251263055322912",
"utcnow_ts": "1580954771273986"
}
}
[02:06:11.302] Invocation finished in 2h19m32.131348884s with status SUCCEEDED