[02:53:00.812] New invocation is queued and will start shortly
[02:53:01.920] Starting the invocation (attempt 1)
[02:53:01.951] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:53:01.952] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:53:01.952] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053944824633786016",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dc30285da98cdfaa2febfd67736440835e8e9e7f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9053944824633786016",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"gitiles_ref:refs/heads/master"
]
}
[02:53:02.945] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1581648782057866",
"id": "8888514762664433312",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc30285da98cdfaa2febfd67736440835e8e9e7f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1581648782624318",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26815",
"builder:Deterministic Linux",
"buildset:commit/git/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053944824633786016",
"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/8888514762664433312/+/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": "1581648782624418",
"url": "https://ci.chromium.org/b/8888514762664433312",
"utcnow_ts": "1581648782925159"
}
}
[02:53:02.945] Task URL: https://ci.chromium.org/b/8888514762664433312
[02:53:02.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:2:0) after 1m0s
[02:53:24.585] Received PubSub notification, asking Buildbucket for the build status
[02:53:24.703] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:2:0)
[02:54:03.066] Timer tick, asking Buildbucket for the build status
[02:54:03.312] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:03.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:4:0) after 1m0s
[02:55:03.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:4:0)
[02:55:03.363] Timer tick, asking Buildbucket for the build status
[02:55:03.466] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:03.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:5:0) after 1m0s
[02:56:03.628] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:5:0)
[02:56:03.628] Timer tick, asking Buildbucket for the build status
[02:56:03.747] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:03.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:6:0) after 1m0s
[02:57:03.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:6:0)
[02:57:03.813] Timer tick, asking Buildbucket for the build status
[02:57:04.105] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:04.105] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:7:0) after 1m0s
[02:58:04.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:7:0)
[02:58:04.151] Timer tick, asking Buildbucket for the build status
[02:58:05.948] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:05.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:8:0) after 1m0s
[02:59:06.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:8:0)
[02:59:06.121] Timer tick, asking Buildbucket for the build status
[02:59:06.429] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:06.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:9:0) after 1m0s
[03:00:06.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:9:0)
[03:00:06.417] Timer tick, asking Buildbucket for the build status
[03:00:06.569] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:06.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:10:0) after 1m0s
[03:01:06.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:10:0)
[03:01:06.676] Timer tick, asking Buildbucket for the build status
[03:01:06.772] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:06.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:11:0) after 1m0s
[03:02:06.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:11:0)
[03:02:06.825] Timer tick, asking Buildbucket for the build status
[03:02:07.064] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:07.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:12:0) after 1m0s
[03:03:07.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:12:0)
[03:03:07.246] Timer tick, asking Buildbucket for the build status
[03:03:08.692] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:13:0) after 1m0s
[03:04:08.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:13:0)
[03:04:08.790] Timer tick, asking Buildbucket for the build status
[03:04:08.889] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:08.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:14:0) after 1m0s
[03:05:08.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:14:0)
[03:05:08.993] Timer tick, asking Buildbucket for the build status
[03:05:09.109] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:09.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:15:0) after 1m0s
[03:06:09.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:15:0)
[03:06:09.131] Timer tick, asking Buildbucket for the build status
[03:06:09.254] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:09.254] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:16:0) after 1m0s
[03:07:09.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:16:0)
[03:07:09.414] Timer tick, asking Buildbucket for the build status
[03:07:09.611] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:09.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:17:0) after 1m0s
[03:08:09.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:17:0)
[03:08:09.713] Timer tick, asking Buildbucket for the build status
[03:08:09.829] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:09.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:18:0) after 1m0s
[03:09:09.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:18:0)
[03:09:09.888] Timer tick, asking Buildbucket for the build status
[03:09:10.020] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:10.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:19:0) after 1m0s
[03:10:10.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:19:0)
[03:10:10.005] Timer tick, asking Buildbucket for the build status
[03:10:10.450] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:10.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:20:0) after 1m0s
[03:11:10.514] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:20:0)
[03:11:10.514] Timer tick, asking Buildbucket for the build status
[03:11:10.625] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:10.625] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:21:0) after 1m0s
[03:12:10.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:21:0)
[03:12:10.697] Timer tick, asking Buildbucket for the build status
[03:12:11.007] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:11.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:22:0) after 1m0s
[03:13:11.069] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:22:0)
[03:13:11.069] Timer tick, asking Buildbucket for the build status
[03:13:11.168] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:11.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:23:0) after 1m0s
[03:14:11.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:23:0)
[03:14:11.346] Timer tick, asking Buildbucket for the build status
[03:14:11.515] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:11.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:24:0) after 1m0s
[03:15:11.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:24:0)
[03:15:11.604] Timer tick, asking Buildbucket for the build status
[03:15:11.804] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:11.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:25:0) after 1m0s
[03:16:12.006] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:25:0)
[03:16:12.006] Timer tick, asking Buildbucket for the build status
[03:16:14.216] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:14.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:26:0) after 1m0s
[03:17:14.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:26:0)
[03:17:14.298] Timer tick, asking Buildbucket for the build status
[03:17:14.452] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:14.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:27:0) after 1m0s
[03:18:14.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:27:0)
[03:18:14.504] Timer tick, asking Buildbucket for the build status
[03:18:14.837] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:14.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:28:0) after 1m0s
[03:19:14.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:28:0)
[03:19:14.939] Timer tick, asking Buildbucket for the build status
[03:19:15.264] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:15.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:29:0) after 1m0s
[03:20:15.457] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:29:0)
[03:20:15.457] Timer tick, asking Buildbucket for the build status
[03:20:15.737] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:15.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:30:0) after 1m0s
[03:21:15.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:30:0)
[03:21:15.879] Timer tick, asking Buildbucket for the build status
[03:21:16.212] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:16.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:31:0) after 1m0s
[03:22:16.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:31:0)
[03:22:16.335] Timer tick, asking Buildbucket for the build status
[03:22:16.435] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:16.435] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:32:0) after 1m0s
[03:23:16.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:32:0)
[03:23:16.569] Timer tick, asking Buildbucket for the build status
[03:23:16.658] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:16.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:33:0) after 1m0s
[03:24:16.697] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:33:0)
[03:24:16.697] Timer tick, asking Buildbucket for the build status
[03:24:16.910] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:16.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:34:0) after 1m0s
[03:25:16.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:34:0)
[03:25:16.988] Timer tick, asking Buildbucket for the build status
[03:25:17.114] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:17.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:35:0) after 1m0s
[03:26:17.227] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:35:0)
[03:26:17.227] Timer tick, asking Buildbucket for the build status
[03:26:17.356] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:17.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:36:0) after 1m0s
[03:27:17.498] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:36:0)
[03:27:17.498] Timer tick, asking Buildbucket for the build status
[03:27:17.613] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:17.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:37:0) after 1m0s
[03:28:17.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:37:0)
[03:28:17.791] Timer tick, asking Buildbucket for the build status
[03:28:17.888] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:17.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:38:0) after 1m0s
[03:29:18.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:38:0)
[03:29:18.111] Timer tick, asking Buildbucket for the build status
[03:29:18.214] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:18.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:39:0) after 1m0s
[03:30:18.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:39:0)
[03:30:18.410] Timer tick, asking Buildbucket for the build status
[03:30:18.509] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:18.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:40:0) after 1m0s
[03:31:18.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:40:0)
[03:31:18.505] Timer tick, asking Buildbucket for the build status
[03:31:18.597] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:18.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:41:0) after 1m0s
[03:32:18.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:41:0)
[03:32:18.689] Timer tick, asking Buildbucket for the build status
[03:32:18.923] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:18.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:42:0) after 1m0s
[03:33:19.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:42:0)
[03:33:19.084] Timer tick, asking Buildbucket for the build status
[03:33:19.390] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:19.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:43:0) after 1m0s
[03:34:19.455] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:43:0)
[03:34:19.455] Timer tick, asking Buildbucket for the build status
[03:34:20.275] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:20.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:44:0) after 1m0s
[03:35:20.465] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:44:0)
[03:35:20.465] Timer tick, asking Buildbucket for the build status
[03:35:20.947] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:20.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:45:0) after 1m0s
[03:36:20.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:45:0)
[03:36:20.978] Timer tick, asking Buildbucket for the build status
[03:36:21.169] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:21.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:46:0) after 1m0s
[03:37:21.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:46:0)
[03:37:21.237] Timer tick, asking Buildbucket for the build status
[03:37:21.426] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:21.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:47:0) after 1m0s
[03:38:21.489] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:47:0)
[03:38:21.489] Timer tick, asking Buildbucket for the build status
[03:38:21.595] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:21.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:48:0) after 1m0s
[03:39:21.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:48:0)
[03:39:21.692] Timer tick, asking Buildbucket for the build status
[03:39:21.855] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:21.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:49:0) after 1m0s
[03:40:21.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:49:0)
[03:40:21.894] Timer tick, asking Buildbucket for the build status
[03:40:22.281] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:22.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:50:0) after 1m0s
[03:41:22.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:50:0)
[03:41:22.335] Timer tick, asking Buildbucket for the build status
[03:41:22.507] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:22.507] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:51:0) after 1m0s
[03:42:22.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:51:0)
[03:42:22.568] Timer tick, asking Buildbucket for the build status
[03:42:22.725] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:22.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:52:0) after 1m0s
[03:43:22.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:52:0)
[03:43:22.752] Timer tick, asking Buildbucket for the build status
[03:43:22.872] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:22.872] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:53:0) after 1m0s
[03:44:22.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:53:0)
[03:44:22.897] Timer tick, asking Buildbucket for the build status
[03:44:22.972] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:22.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:54:0) after 1m0s
[03:45:23.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:54:0)
[03:45:23.022] Timer tick, asking Buildbucket for the build status
[03:45:23.133] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:23.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:55:0) after 1m0s
[03:46:23.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:55:0)
[03:46:23.156] Timer tick, asking Buildbucket for the build status
[03:46:23.313] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:23.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:56:0) after 1m0s
[03:47:23.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:56:0)
[03:47:23.361] Timer tick, asking Buildbucket for the build status
[03:47:23.588] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:23.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:57:0) after 1m0s
[03:48:23.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:57:0)
[03:48:23.674] Timer tick, asking Buildbucket for the build status
[03:48:23.921] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:23.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:58:0) after 1m0s
[03:49:23.953] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:58:0)
[03:49:23.953] Timer tick, asking Buildbucket for the build status
[03:49:24.044] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:24.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:59:0) after 1m0s
[03:50:24.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:59:0)
[03:50:24.102] Timer tick, asking Buildbucket for the build status
[03:50:24.208] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:24.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:60:0) after 1m0s
[03:51:24.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:60:0)
[03:51:24.295] Timer tick, asking Buildbucket for the build status
[03:51:24.419] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:24.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:61:0) after 1m0s
[03:52:24.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:61:0)
[03:52:24.435] Timer tick, asking Buildbucket for the build status
[03:52:24.540] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:24.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:62:0) after 1m0s
[03:53:24.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:62:0)
[03:53:24.564] Timer tick, asking Buildbucket for the build status
[03:53:24.652] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:24.652] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:63:0) after 1m0s
[03:54:24.773] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:63:0)
[03:54:24.773] Timer tick, asking Buildbucket for the build status
[03:54:24.982] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:24.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:64:0) after 1m0s
[03:55:25.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:64:0)
[03:55:25.092] Timer tick, asking Buildbucket for the build status
[03:55:25.486] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:25.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:65:0) after 1m0s
[03:56:25.568] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:65:0)
[03:56:25.568] Timer tick, asking Buildbucket for the build status
[03:56:25.877] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:25.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:66:0) after 1m0s
[03:57:25.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:66:0)
[03:57:25.937] Timer tick, asking Buildbucket for the build status
[03:57:26.031] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:26.031] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:67:0) after 1m0s
[03:58:26.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:67:0)
[03:58:26.153] Timer tick, asking Buildbucket for the build status
[03:58:26.697] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:26.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:68:0) after 1m0s
[03:59:26.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:68:0)
[03:59:26.759] Timer tick, asking Buildbucket for the build status
[03:59:27.078] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:27.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:69:0) after 1m0s
[04:00:27.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:69:0)
[04:00:27.108] Timer tick, asking Buildbucket for the build status
[04:00:27.212] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:27.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:70:0) after 1m0s
[04:01:27.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:70:0)
[04:01:27.272] Timer tick, asking Buildbucket for the build status
[04:01:27.374] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:27.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:71:0) after 1m0s
[04:02:27.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:71:0)
[04:02:27.423] Timer tick, asking Buildbucket for the build status
[04:02:27.575] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:27.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:72:0) after 1m0s
[04:03:27.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:72:0)
[04:03:27.615] Timer tick, asking Buildbucket for the build status
[04:03:27.893] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:27.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:73:0) after 1m0s
[04:04:27.918] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:73:0)
[04:04:27.918] Timer tick, asking Buildbucket for the build status
[04:04:28.279] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:28.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:74:0) after 1m0s
[04:05:28.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:74:0)
[04:05:28.294] Timer tick, asking Buildbucket for the build status
[04:05:28.480] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:28.480] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:75:0) after 1m0s
[04:06:28.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:75:0)
[04:06:28.532] Timer tick, asking Buildbucket for the build status
[04:06:28.868] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:28.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:76:0) after 1m0s
[04:07:28.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:76:0)
[04:07:28.848] Timer tick, asking Buildbucket for the build status
[04:07:28.953] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:28.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:77:0) after 1m0s
[04:08:29.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:77:0)
[04:08:29.009] Timer tick, asking Buildbucket for the build status
[04:08:29.256] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:29.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:78:0) after 1m0s
[04:09:29.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:78:0)
[04:09:29.336] Timer tick, asking Buildbucket for the build status
[04:09:29.727] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:29.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:79:0) after 1m0s
[04:10:29.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:79:0)
[04:10:29.780] Timer tick, asking Buildbucket for the build status
[04:10:29.881] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:29.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:80:0) after 1m0s
[04:11:29.865] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:80:0)
[04:11:29.865] Timer tick, asking Buildbucket for the build status
[04:11:30.145] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:30.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:81:0) after 1m0s
[04:12:30.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:81:0)
[04:12:30.219] Timer tick, asking Buildbucket for the build status
[04:12:30.959] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:30.959] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:82:0) after 1m0s
[04:13:31.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:82:0)
[04:13:31.005] Timer tick, asking Buildbucket for the build status
[04:13:31.192] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:31.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:83:0) after 1m0s
[04:14:31.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:83:0)
[04:14:31.304] Timer tick, asking Buildbucket for the build status
[04:14:31.396] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:31.396] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:84:0) after 1m0s
[04:15:31.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:84:0)
[04:15:31.424] Timer tick, asking Buildbucket for the build status
[04:15:31.610] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:31.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:85:0) after 1m0s
[04:16:31.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:85:0)
[04:16:31.702] Timer tick, asking Buildbucket for the build status
[04:16:32.033] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:32.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:86:0) after 1m0s
[04:17:32.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:86:0)
[04:17:32.066] Timer tick, asking Buildbucket for the build status
[04:17:32.193] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:32.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:87:0) after 1m0s
[04:18:32.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:87:0)
[04:18:32.210] Timer tick, asking Buildbucket for the build status
[04:18:32.314] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:32.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:88:0) after 1m0s
[04:19:32.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:88:0)
[04:19:32.342] Timer tick, asking Buildbucket for the build status
[04:19:32.434] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:32.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:89:0) after 1m0s
[04:20:32.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:89:0)
[04:20:32.492] Timer tick, asking Buildbucket for the build status
[04:20:33.042] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:33.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:90:0) after 1m0s
[04:21:33.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:90:0)
[04:21:33.044] Timer tick, asking Buildbucket for the build status
[04:21:33.190] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:33.190] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:91:0) after 1m0s
[04:22:33.231] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:91:0)
[04:22:33.231] Timer tick, asking Buildbucket for the build status
[04:22:33.468] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:33.468] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:92:0) after 1m0s
[04:23:33.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:92:0)
[04:23:33.592] Timer tick, asking Buildbucket for the build status
[04:23:33.831] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:33.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:93:0) after 1m0s
[04:24:34.031] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:93:0)
[04:24:34.031] Timer tick, asking Buildbucket for the build status
[04:24:34.160] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:34.160] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:94:0) after 1m0s
[04:25:34.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:94:0)
[04:25:34.233] Timer tick, asking Buildbucket for the build status
[04:25:34.348] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:95:0) after 1m0s
[04:26:34.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:95:0)
[04:26:34.442] Timer tick, asking Buildbucket for the build status
[04:26:34.596] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:34.596] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:96:0) after 1m0s
[04:27:34.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:96:0)
[04:27:34.696] Timer tick, asking Buildbucket for the build status
[04:27:34.975] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:34.975] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:97:0) after 1m0s
[04:28:34.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:97:0)
[04:28:34.952] Timer tick, asking Buildbucket for the build status
[04:28:35.320] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:35.320] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:98:0) after 1m0s
[04:29:35.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:98:0)
[04:29:35.421] Timer tick, asking Buildbucket for the build status
[04:29:36.081] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:36.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:99:0) after 1m0s
[04:30:36.142] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:99:0)
[04:30:36.142] Timer tick, asking Buildbucket for the build status
[04:30:36.486] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:36.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:100:0) after 1m0s
[04:31:36.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:100:0)
[04:31:36.519] Timer tick, asking Buildbucket for the build status
[04:31:36.682] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:36.682] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:101:0) after 1m0s
[04:32:36.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:101:0)
[04:32:36.705] Timer tick, asking Buildbucket for the build status
[04:32:36.806] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:36.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:102:0) after 1m0s
[04:33:36.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:102:0)
[04:33:36.843] Timer tick, asking Buildbucket for the build status
[04:33:36.951] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:36.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:103:0) after 1m0s
[04:34:36.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:103:0)
[04:34:36.995] Timer tick, asking Buildbucket for the build status
[04:34:37.114] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:37.114] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:104:0) after 1m0s
[04:35:37.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:104:0)
[04:35:37.180] Timer tick, asking Buildbucket for the build status
[04:35:37.319] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:37.320] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:105:0) after 1m0s
[04:36:37.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:105:0)
[04:36:37.360] Timer tick, asking Buildbucket for the build status
[04:36:37.916] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:37.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:106:0) after 1m0s
[04:37:37.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:106:0)
[04:37:37.910] Timer tick, asking Buildbucket for the build status
[04:37:38.010] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:38.010] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:107:0) after 1m0s
[04:38:38.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:107:0)
[04:38:38.037] Timer tick, asking Buildbucket for the build status
[04:38:38.275] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:38.275] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:108:0) after 1m0s
[04:39:38.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:108:0)
[04:39:38.300] Timer tick, asking Buildbucket for the build status
[04:39:38.476] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:38.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:109:0) after 1m0s
[04:40:38.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:109:0)
[04:40:38.520] Timer tick, asking Buildbucket for the build status
[04:40:38.639] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:38.640] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:110:0) after 1m0s
[04:41:38.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:110:0)
[04:41:38.757] Timer tick, asking Buildbucket for the build status
[04:41:38.892] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:38.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:111:0) after 1m0s
[04:42:39.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:111:0)
[04:42:39.058] Timer tick, asking Buildbucket for the build status
[04:42:39.210] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:39.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:112:0) after 1m0s
[04:43:39.266] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:112:0)
[04:43:39.266] Timer tick, asking Buildbucket for the build status
[04:43:39.363] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:39.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:113:0) after 1m0s
[04:44:39.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:113:0)
[04:44:39.477] Timer tick, asking Buildbucket for the build status
[04:44:40.006] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:40.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:114:0) after 1m0s
[04:45:40.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:114:0)
[04:45:40.051] Timer tick, asking Buildbucket for the build status
[04:45:40.191] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:40.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:115:0) after 1m0s
[04:46:40.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:115:0)
[04:46:40.239] Timer tick, asking Buildbucket for the build status
[04:46:40.356] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:40.356] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:116:0) after 1m0s
[04:47:40.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:116:0)
[04:47:40.493] Timer tick, asking Buildbucket for the build status
[04:47:40.577] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:40.577] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:117:0) after 1m0s
[04:48:40.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:117:0)
[04:48:40.688] Timer tick, asking Buildbucket for the build status
[04:48:40.910] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:40.910] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:118:0) after 1m0s
[04:49:40.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:118:0)
[04:49:40.991] Timer tick, asking Buildbucket for the build status
[04:49:41.119] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:41.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:119:0) after 1m0s
[04:50:41.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:119:0)
[04:50:41.213] Timer tick, asking Buildbucket for the build status
[04:50:41.313] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:41.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:120:0) after 1m0s
[04:51:41.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:120:0)
[04:51:41.372] Timer tick, asking Buildbucket for the build status
[04:51:41.459] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:41.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:121:0) after 1m0s
[04:52:41.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:121:0)
[04:52:41.432] Timer tick, asking Buildbucket for the build status
[04:52:41.673] Build 8888514762664433312: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:41.673] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9053944824633786016:122:0) after 1m0s
[04:53:26.153] Received PubSub notification, asking Buildbucket for the build status
[04:53:26.242] Build 8888514762664433312: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:53:26.242] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1581655991172435",
"created_by": "project:chromium",
"created_ts": "1581648782057866",
"id": "8888514762664433312",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc30285da98cdfaa2febfd67736440835e8e9e7f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-35-cvpa\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 26815, \"got_angle_revision\": \"4f9608ca6afd5169585fae2664a7666219f4389a\", \"got_dawn_revision\": \"2fd618192985122aafb494ac5e9a39f572ef46fc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"dc30285da98cdfaa2febfd67736440835e8e9e7f\", \"got_revision_cp\": \"refs/heads/master@{#741327}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"f9f999f5a2eb6dd586a1da03e6b400d044ae6022\", \"got_v8_revision\": \"4deaf25c8262feb7fc57f0c7ebb75f6ad54304d9\", \"got_v8_revision_cp\": \"refs/heads/8.2.74@{#1}\", \"got_webrtc_revision\": \"0618cbc98994ac850c47b926ff6ff73456f9f793\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30520}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dc30285da98cdfaa2febfd67736440835e8e9e7f\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_f5610824250c57fc28679fbc8606252c3dbaca731fb7f2a4bebf1e0fc7f48a3a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-35-cvpa\"], \"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\": [\"4815-21a95a1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1581648783400979",
"status": "COMPLETED",
"status_changed_ts": "1581656005675901",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/26815",
"builder:Deterministic Linux",
"buildset:commit/git/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dc30285da98cdfaa2febfd67736440835e8e9e7f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053944824633786016",
"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/8888514762664433312/+/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:4a5a6eae6669ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1581656005681849",
"url": "https://ci.chromium.org/b/8888514762664433312",
"utcnow_ts": "1581656006205183"
}
}
[04:53:26.243] Invocation finished in 2h0m25.447483778s with status SUCCEEDED