[05:35:05.251] New invocation is queued and will start shortly
[05:35:07.501] Starting the invocation (attempt 1)
[05:35:07.570] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:35:07.570] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:35:07.570] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040798067693927744",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ed67c19ad4039f6271aec8292138ce6069437475\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9040798067693927744",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/ed67c19ad4039f6271aec8292138ce6069437475",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed67c19ad4039f6271aec8292138ce6069437475",
"gitiles_ref:refs/heads/master"
]
}
[05:35:08.337] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594186507659979",
"id": "8875368004503293088",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed67c19ad4039f6271aec8292138ce6069437475\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594186508165338",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28478",
"builder:Deterministic Linux",
"buildset:commit/git/ed67c19ad4039f6271aec8292138ce6069437475",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed67c19ad4039f6271aec8292138ce6069437475",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040798067693927744",
"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/8875368004503293088/+/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": "1594186508165477",
"url": "https://ci.chromium.org/b/8875368004503293088",
"utcnow_ts": "1594186508323084"
}
}
[05:35:08.337] Task URL: https://ci.chromium.org/b/8875368004503293088
[05:35:08.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:2:0) after 1m0s
[05:35:17.749] Received PubSub notification, asking Buildbucket for the build status
[05:35:17.878] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:08.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:2:0)
[05:36:08.414] Timer tick, asking Buildbucket for the build status
[05:36:08.723] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:08.723] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:4:0) after 1m0s
[05:37:08.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:4:0)
[05:37:08.782] Timer tick, asking Buildbucket for the build status
[05:37:09.906] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:09.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:5:0) after 1m0s
[05:38:10.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:5:0)
[05:38:10.076] Timer tick, asking Buildbucket for the build status
[05:38:11.982] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:11.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:6:0) after 1m0s
[05:39:12.032] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:6:0)
[05:39:12.032] Timer tick, asking Buildbucket for the build status
[05:39:12.240] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:12.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:7:0) after 1m0s
[05:40:12.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:7:0)
[05:40:12.265] Timer tick, asking Buildbucket for the build status
[05:40:12.481] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:12.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:8:0) after 1m0s
[05:41:12.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:8:0)
[05:41:12.505] Timer tick, asking Buildbucket for the build status
[05:41:12.985] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:12.985] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:9:0) after 1m0s
[05:42:13.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:9:0)
[05:42:13.221] Timer tick, asking Buildbucket for the build status
[05:42:13.501] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:13.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:10:0) after 1m0s
[05:43:13.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:10:0)
[05:43:13.662] Timer tick, asking Buildbucket for the build status
[05:43:14.694] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:14.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:11:0) after 1m0s
[05:44:14.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:11:0)
[05:44:14.718] Timer tick, asking Buildbucket for the build status
[05:44:15.079] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:15.079] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:12:0) after 1m0s
[05:45:15.101] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:12:0)
[05:45:15.101] Timer tick, asking Buildbucket for the build status
[05:45:15.834] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:15.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:13:0) after 1m0s
[05:46:15.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:13:0)
[05:46:15.827] Timer tick, asking Buildbucket for the build status
[05:46:16.227] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:16.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:14:0) after 1m0s
[05:47:16.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:14:0)
[05:47:16.299] Timer tick, asking Buildbucket for the build status
[05:47:16.574] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:16.574] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:15:0) after 1m0s
[05:48:16.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:15:0)
[05:48:16.630] Timer tick, asking Buildbucket for the build status
[05:48:16.782] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:16.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:16:0) after 1m0s
[05:49:16.860] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:16:0)
[05:49:16.860] Timer tick, asking Buildbucket for the build status
[05:49:17.081] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:17.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:17:0) after 1m0s
[05:50:17.155] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:17:0)
[05:50:17.155] Timer tick, asking Buildbucket for the build status
[05:50:18.702] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:18.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:18:0) after 1m0s
[05:51:18.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:18:0)
[05:51:18.743] Timer tick, asking Buildbucket for the build status
[05:51:18.889] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:18.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:19:0) after 1m0s
[05:52:19.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:19:0)
[05:52:19.002] Timer tick, asking Buildbucket for the build status
[05:52:19.153] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:19.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:20:0) after 1m0s
[05:53:19.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:20:0)
[05:53:19.182] Timer tick, asking Buildbucket for the build status
[05:53:19.337] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:19.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:21:0) after 1m0s
[05:54:19.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:21:0)
[05:54:19.361] Timer tick, asking Buildbucket for the build status
[05:54:19.528] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:19.528] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:22:0) after 1m0s
[05:55:19.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:22:0)
[05:55:19.573] Timer tick, asking Buildbucket for the build status
[05:55:19.805] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:19.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:23:0) after 1m0s
[05:56:19.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:23:0)
[05:56:19.838] Timer tick, asking Buildbucket for the build status
[05:56:20.725] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:20.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:24:0) after 1m0s
[05:57:20.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:24:0)
[05:57:20.784] Timer tick, asking Buildbucket for the build status
[05:57:20.945] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:20.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:25:0) after 1m0s
[05:58:20.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:25:0)
[05:58:20.977] Timer tick, asking Buildbucket for the build status
[05:58:21.221] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:21.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:26:0) after 1m0s
[05:59:21.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:26:0)
[05:59:21.244] Timer tick, asking Buildbucket for the build status
[05:59:21.402] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:21.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:27:0) after 1m0s
[06:00:21.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:27:0)
[06:00:21.433] Timer tick, asking Buildbucket for the build status
[06:00:21.789] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:21.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:28:0) after 1m0s
[06:01:21.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:28:0)
[06:01:21.950] Timer tick, asking Buildbucket for the build status
[06:01:22.228] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:22.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:29:0) after 1m0s
[06:02:22.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:29:0)
[06:02:22.269] Timer tick, asking Buildbucket for the build status
[06:02:22.683] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:22.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:30:0) after 1m0s
[06:03:22.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:30:0)
[06:03:22.757] Timer tick, asking Buildbucket for the build status
[06:03:23.484] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:23.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:31:0) after 1m0s
[06:04:23.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:31:0)
[06:04:23.650] Timer tick, asking Buildbucket for the build status
[06:04:23.817] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:23.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:32:0) after 1m0s
[06:05:23.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:32:0)
[06:05:23.885] Timer tick, asking Buildbucket for the build status
[06:05:24.063] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:24.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:33:0) after 1m0s
[06:06:24.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:33:0)
[06:06:24.104] Timer tick, asking Buildbucket for the build status
[06:06:24.244] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:34:0) after 1m0s
[06:07:24.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:34:0)
[06:07:24.351] Timer tick, asking Buildbucket for the build status
[06:07:24.571] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:24.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:35:0) after 1m0s
[06:08:24.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:35:0)
[06:08:24.666] Timer tick, asking Buildbucket for the build status
[06:08:24.879] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:24.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:36:0) after 1m0s
[06:09:24.944] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:36:0)
[06:09:24.944] Timer tick, asking Buildbucket for the build status
[06:09:25.099] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:25.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:37:0) after 1m0s
[06:10:25.121] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:37:0)
[06:10:25.121] Timer tick, asking Buildbucket for the build status
[06:10:25.316] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:25.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:38:0) after 1m0s
[06:11:25.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:38:0)
[06:11:25.347] Timer tick, asking Buildbucket for the build status
[06:11:25.644] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:25.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:39:0) after 1m0s
[06:12:25.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:39:0)
[06:12:25.674] Timer tick, asking Buildbucket for the build status
[06:12:26.238] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:26.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:40:0) after 1m0s
[06:13:26.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:40:0)
[06:13:26.248] Timer tick, asking Buildbucket for the build status
[06:13:26.613] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:26.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:41:0) after 1m0s
[06:14:26.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:41:0)
[06:14:26.658] Timer tick, asking Buildbucket for the build status
[06:14:27.025] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:27.025] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:42:0) after 1m0s
[06:15:27.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:42:0)
[06:15:27.027] Timer tick, asking Buildbucket for the build status
[06:15:27.372] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:27.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:43:0) after 1m0s
[06:16:27.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:43:0)
[06:16:27.404] Timer tick, asking Buildbucket for the build status
[06:16:27.582] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:27.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:44:0) after 1m0s
[06:17:27.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:44:0)
[06:17:27.660] Timer tick, asking Buildbucket for the build status
[06:17:27.804] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:27.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:45:0) after 1m0s
[06:18:27.881] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:45:0)
[06:18:27.881] Timer tick, asking Buildbucket for the build status
[06:18:30.311] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:30.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:46:0) after 1m0s
[06:19:30.371] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:46:0)
[06:19:30.371] Timer tick, asking Buildbucket for the build status
[06:19:32.038] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:32.038] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:47:0) after 1m0s
[06:20:32.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:47:0)
[06:20:32.063] Timer tick, asking Buildbucket for the build status
[06:20:32.441] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:32.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:48:0) after 1m0s
[06:21:32.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:48:0)
[06:21:32.486] Timer tick, asking Buildbucket for the build status
[06:21:32.702] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:32.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:49:0) after 1m0s
[06:22:32.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:49:0)
[06:22:32.728] Timer tick, asking Buildbucket for the build status
[06:22:32.835] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:32.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:50:0) after 1m0s
[06:23:32.892] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:50:0)
[06:23:32.892] Timer tick, asking Buildbucket for the build status
[06:23:33.181] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:33.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:51:0) after 1m0s
[06:24:33.205] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:51:0)
[06:24:33.205] Timer tick, asking Buildbucket for the build status
[06:24:33.769] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:33.769] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:52:0) after 1m0s
[06:25:33.876] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:52:0)
[06:25:33.876] Timer tick, asking Buildbucket for the build status
[06:25:34.013] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:34.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:53:0) after 1m0s
[06:26:34.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:53:0)
[06:26:34.109] Timer tick, asking Buildbucket for the build status
[06:26:42.272] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:42.272] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:54:0) after 1m0s
[06:27:42.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:54:0)
[06:27:42.408] Timer tick, asking Buildbucket for the build status
[06:27:43.158] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:43.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:55:0) after 1m0s
[06:28:43.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:55:0)
[06:28:43.220] Timer tick, asking Buildbucket for the build status
[06:28:43.618] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:43.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:56:0) after 1m0s
[06:29:43.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:56:0)
[06:29:43.643] Timer tick, asking Buildbucket for the build status
[06:29:43.786] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:43.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:57:0) after 1m0s
[06:30:43.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:57:0)
[06:30:43.811] Timer tick, asking Buildbucket for the build status
[06:30:44.657] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:44.657] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:58:0) after 1m0s
[06:31:44.693] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:58:0)
[06:31:44.693] Timer tick, asking Buildbucket for the build status
[06:31:45.071] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:45.071] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:59:0) after 1m0s
[06:32:45.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:59:0)
[06:32:45.103] Timer tick, asking Buildbucket for the build status
[06:32:45.392] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:45.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:60:0) after 1m0s
[06:33:45.418] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:60:0)
[06:33:45.418] Timer tick, asking Buildbucket for the build status
[06:33:45.611] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:45.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:61:0) after 1m0s
[06:34:45.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:61:0)
[06:34:45.592] Timer tick, asking Buildbucket for the build status
[06:34:45.767] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:45.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:62:0) after 1m0s
[06:35:45.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:62:0)
[06:35:45.821] Timer tick, asking Buildbucket for the build status
[06:35:46.220] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:46.220] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:63:0) after 1m0s
[06:36:46.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:63:0)
[06:36:46.259] Timer tick, asking Buildbucket for the build status
[06:36:46.732] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:46.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:64:0) after 1m0s
[06:37:46.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:64:0)
[06:37:46.759] Timer tick, asking Buildbucket for the build status
[06:37:47.147] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:47.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:65:0) after 1m0s
[06:38:47.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:65:0)
[06:38:47.206] Timer tick, asking Buildbucket for the build status
[06:38:47.359] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:47.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:66:0) after 1m0s
[06:39:47.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:66:0)
[06:39:47.391] Timer tick, asking Buildbucket for the build status
[06:39:47.525] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:47.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:67:0) after 1m0s
[06:40:47.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:67:0)
[06:40:47.557] Timer tick, asking Buildbucket for the build status
[06:40:48.153] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:48.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:68:0) after 1m0s
[06:41:48.178] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:68:0)
[06:41:48.178] Timer tick, asking Buildbucket for the build status
[06:41:48.304] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:48.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:69:0) after 1m0s
[06:42:48.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:69:0)
[06:42:48.410] Timer tick, asking Buildbucket for the build status
[06:42:48.550] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:48.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:70:0) after 1m0s
[06:43:48.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:70:0)
[06:43:48.558] Timer tick, asking Buildbucket for the build status
[06:43:48.814] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:48.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:71:0) after 1m0s
[06:44:48.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:71:0)
[06:44:48.852] Timer tick, asking Buildbucket for the build status
[06:44:49.476] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:49.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:72:0) after 1m0s
[06:45:49.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:72:0)
[06:45:49.549] Timer tick, asking Buildbucket for the build status
[06:45:49.698] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:49.698] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:73:0) after 1m0s
[06:46:49.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:73:0)
[06:46:49.833] Timer tick, asking Buildbucket for the build status
[06:46:50.300] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:50.300] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:74:0) after 1m0s
[06:47:50.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:74:0)
[06:47:50.385] Timer tick, asking Buildbucket for the build status
[06:47:50.797] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:50.797] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:75:0) after 1m0s
[06:48:50.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:75:0)
[06:48:50.851] Timer tick, asking Buildbucket for the build status
[06:48:51.032] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:51.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:76:0) after 1m0s
[06:49:51.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:76:0)
[06:49:51.014] Timer tick, asking Buildbucket for the build status
[06:49:51.152] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:51.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:77:0) after 1m0s
[06:50:51.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:77:0)
[06:50:51.206] Timer tick, asking Buildbucket for the build status
[06:50:52.018] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:52.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:78:0) after 1m0s
[06:51:52.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:78:0)
[06:51:52.233] Timer tick, asking Buildbucket for the build status
[06:51:52.599] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:52.599] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:79:0) after 1m0s
[06:52:52.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:79:0)
[06:52:52.723] Timer tick, asking Buildbucket for the build status
[06:52:53.080] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:53.080] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:80:0) after 1m0s
[06:53:53.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:80:0)
[06:53:53.145] Timer tick, asking Buildbucket for the build status
[06:53:53.364] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:53.364] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:81:0) after 1m0s
[06:54:53.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:81:0)
[06:54:53.421] Timer tick, asking Buildbucket for the build status
[06:54:53.735] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:53.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:82:0) after 1m0s
[06:55:53.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:82:0)
[06:55:53.771] Timer tick, asking Buildbucket for the build status
[06:55:55.017] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:55.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:83:0) after 1m0s
[06:56:55.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:83:0)
[06:56:55.092] Timer tick, asking Buildbucket for the build status
[06:56:55.502] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:55.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:84:0) after 1m0s
[06:57:55.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:84:0)
[06:57:55.657] Timer tick, asking Buildbucket for the build status
[06:57:55.793] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:55.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:85:0) after 1m0s
[06:58:55.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:85:0)
[06:58:55.989] Timer tick, asking Buildbucket for the build status
[06:58:56.196] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:56.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:86:0) after 1m0s
[06:59:56.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:86:0)
[06:59:56.273] Timer tick, asking Buildbucket for the build status
[06:59:56.399] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:56.399] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:87:0) after 1m0s
[07:00:56.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:87:0)
[07:00:56.399] Timer tick, asking Buildbucket for the build status
[07:00:56.683] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:56.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:88:0) after 1m0s
[07:01:56.737] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:88:0)
[07:01:56.737] Timer tick, asking Buildbucket for the build status
[07:01:57.733] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:57.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:89:0) after 1m0s
[07:02:57.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:89:0)
[07:02:57.786] Timer tick, asking Buildbucket for the build status
[07:02:58.113] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:58.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:90:0) after 1m0s
[07:03:58.187] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:90:0)
[07:03:58.187] Timer tick, asking Buildbucket for the build status
[07:03:58.519] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:58.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:91:0) after 1m0s
[07:04:58.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:91:0)
[07:04:58.556] Timer tick, asking Buildbucket for the build status
[07:04:58.778] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:58.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:92:0) after 1m0s
[07:05:58.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:92:0)
[07:05:58.806] Timer tick, asking Buildbucket for the build status
[07:05:59.311] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:59.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:93:0) after 1m0s
[07:06:59.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:93:0)
[07:06:59.351] Timer tick, asking Buildbucket for the build status
[07:06:59.578] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:59.578] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:94:0) after 1m0s
[07:07:59.633] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:94:0)
[07:07:59.633] Timer tick, asking Buildbucket for the build status
[07:07:59.971] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:59.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:95:0) after 1m0s
[07:09:00.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:95:0)
[07:09:00.028] Timer tick, asking Buildbucket for the build status
[07:09:00.297] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:00.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:96:0) after 1m0s
[07:10:00.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:96:0)
[07:10:00.327] Timer tick, asking Buildbucket for the build status
[07:10:00.466] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:00.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:97:0) after 1m0s
[07:11:00.544] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:97:0)
[07:11:00.544] Timer tick, asking Buildbucket for the build status
[07:11:00.705] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:00.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:98:0) after 1m0s
[07:12:00.771] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:98:0)
[07:12:00.771] Timer tick, asking Buildbucket for the build status
[07:12:01.095] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:01.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:99:0) after 1m0s
[07:13:01.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:99:0)
[07:13:01.167] Timer tick, asking Buildbucket for the build status
[07:13:01.391] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:01.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:100:0) after 1m0s
[07:14:02.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:100:0)
[07:14:02.592] Timer tick, asking Buildbucket for the build status
[07:14:03.331] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:03.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:101:0) after 1m0s
[07:15:03.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:101:0)
[07:15:03.392] Timer tick, asking Buildbucket for the build status
[07:15:03.616] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:03.616] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:102:0) after 1m0s
[07:16:03.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:102:0)
[07:16:03.679] Timer tick, asking Buildbucket for the build status
[07:16:03.851] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:03.851] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:103:0) after 1m0s
[07:17:03.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:103:0)
[07:17:03.993] Timer tick, asking Buildbucket for the build status
[07:17:04.188] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:04.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:104:0) after 1m0s
[07:18:04.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:104:0)
[07:18:04.194] Timer tick, asking Buildbucket for the build status
[07:18:04.331] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:04.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:105:0) after 1m0s
[07:19:04.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:105:0)
[07:19:04.492] Timer tick, asking Buildbucket for the build status
[07:19:06.452] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:06.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:106:0) after 1m0s
[07:20:06.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:106:0)
[07:20:06.487] Timer tick, asking Buildbucket for the build status
[07:20:06.604] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:06.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:107:0) after 1m0s
[07:21:06.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:107:0)
[07:21:06.646] Timer tick, asking Buildbucket for the build status
[07:21:06.806] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:06.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:108:0) after 1m0s
[07:22:06.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:108:0)
[07:22:06.875] Timer tick, asking Buildbucket for the build status
[07:22:07.240] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:07.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:109:0) after 1m0s
[07:23:07.298] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:109:0)
[07:23:07.298] Timer tick, asking Buildbucket for the build status
[07:23:07.782] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:07.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:110:0) after 1m0s
[07:24:07.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:110:0)
[07:24:07.842] Timer tick, asking Buildbucket for the build status
[07:24:09.663] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:09.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:111:0) after 1m0s
[07:25:09.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:111:0)
[07:25:09.736] Timer tick, asking Buildbucket for the build status
[07:25:10.181] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:10.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:112:0) after 1m0s
[07:26:10.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:112:0)
[07:26:10.265] Timer tick, asking Buildbucket for the build status
[07:26:10.437] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:10.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:113:0) after 1m0s
[07:27:10.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:113:0)
[07:27:10.588] Timer tick, asking Buildbucket for the build status
[07:27:10.767] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:10.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:114:0) after 1m0s
[07:28:10.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:114:0)
[07:28:10.851] Timer tick, asking Buildbucket for the build status
[07:28:11.083] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:11.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:115:0) after 1m0s
[07:29:11.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:115:0)
[07:29:11.068] Timer tick, asking Buildbucket for the build status
[07:29:11.192] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:11.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:116:0) after 1m0s
[07:30:11.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:116:0)
[07:30:11.195] Timer tick, asking Buildbucket for the build status
[07:30:11.567] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:11.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:117:0) after 1m0s
[07:31:11.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:117:0)
[07:31:11.659] Timer tick, asking Buildbucket for the build status
[07:31:11.873] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:11.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:118:0) after 1m0s
[07:32:12.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:118:0)
[07:32:12.180] Timer tick, asking Buildbucket for the build status
[07:32:12.359] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:12.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:119:0) after 1m0s
[07:33:12.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:119:0)
[07:33:12.643] Timer tick, asking Buildbucket for the build status
[07:33:12.757] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:12.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:120:0) after 1m0s
[07:34:12.992] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:120:0)
[07:34:12.992] Timer tick, asking Buildbucket for the build status
[07:34:13.109] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:13.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:121:0) after 1m0s
[07:35:13.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:121:0)
[07:35:13.248] Timer tick, asking Buildbucket for the build status
[07:35:13.365] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:13.365] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:122:0) after 1m0s
[07:36:13.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:122:0)
[07:36:13.909] Timer tick, asking Buildbucket for the build status
[07:36:14.359] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:14.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:123:0) after 1m0s
[07:37:14.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:123:0)
[07:37:14.405] Timer tick, asking Buildbucket for the build status
[07:37:14.609] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:14.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:124:0) after 1m0s
[07:38:14.690] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:124:0)
[07:38:14.690] Timer tick, asking Buildbucket for the build status
[07:38:14.931] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:14.931] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:125:0) after 1m0s
[07:39:15.016] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:125:0)
[07:39:15.016] Timer tick, asking Buildbucket for the build status
[07:39:15.377] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:15.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:126:0) after 1m0s
[07:40:15.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:126:0)
[07:40:15.432] Timer tick, asking Buildbucket for the build status
[07:40:15.669] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:15.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:127:0) after 1m0s
[07:41:15.696] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:127:0)
[07:41:15.696] Timer tick, asking Buildbucket for the build status
[07:41:15.915] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:15.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:128:0) after 1m0s
[07:42:15.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:128:0)
[07:42:15.964] Timer tick, asking Buildbucket for the build status
[07:42:16.169] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:16.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:129:0) after 1m0s
[07:43:16.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:129:0)
[07:43:16.283] Timer tick, asking Buildbucket for the build status
[07:43:17.383] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:17.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:130:0) after 1m0s
[07:44:17.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:130:0)
[07:44:17.421] Timer tick, asking Buildbucket for the build status
[07:44:17.658] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:17.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:131:0) after 1m0s
[07:45:17.665] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:131:0)
[07:45:17.665] Timer tick, asking Buildbucket for the build status
[07:45:18.264] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:18.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:132:0) after 1m0s
[07:46:18.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:132:0)
[07:46:18.296] Timer tick, asking Buildbucket for the build status
[07:46:18.447] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:18.447] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:133:0) after 1m0s
[07:47:18.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:133:0)
[07:47:18.493] Timer tick, asking Buildbucket for the build status
[07:47:19.172] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:19.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:134:0) after 1m0s
[07:48:19.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:134:0)
[07:48:19.273] Timer tick, asking Buildbucket for the build status
[07:48:19.509] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:19.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:135:0) after 1m0s
[07:49:19.523] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:135:0)
[07:49:19.523] Timer tick, asking Buildbucket for the build status
[07:49:19.767] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:19.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:136:0) after 1m0s
[07:50:19.788] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:136:0)
[07:50:19.789] Timer tick, asking Buildbucket for the build status
[07:50:19.958] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:19.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:137:0) after 1m0s
[07:51:19.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:137:0)
[07:51:19.997] Timer tick, asking Buildbucket for the build status
[07:51:20.142] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:20.142] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:138:0) after 1m0s
[07:52:20.198] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:138:0)
[07:52:20.198] Timer tick, asking Buildbucket for the build status
[07:52:20.401] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:20.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:139:0) after 1m0s
[07:53:21.147] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:139:0)
[07:53:21.147] Timer tick, asking Buildbucket for the build status
[07:53:21.372] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:21.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:140:0) after 1m0s
[07:54:21.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:140:0)
[07:54:21.591] Timer tick, asking Buildbucket for the build status
[07:54:21.905] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:21.905] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:141:0) after 1m0s
[07:55:21.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:141:0)
[07:55:21.986] Timer tick, asking Buildbucket for the build status
[07:55:23.908] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:23.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:142:0) after 1m0s
[07:56:24.290] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:142:0)
[07:56:24.290] Timer tick, asking Buildbucket for the build status
[07:56:24.438] Build 8875368004503293088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:24.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040798067693927744:143:0) after 1m0s
[07:56:45.515] Received PubSub notification, asking Buildbucket for the build status
[07:56:45.672] Build 8875368004503293088: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:56:45.672] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594195004698210",
"created_by": "project:chromium",
"created_ts": "1594186507659979",
"id": "8875368004503293088",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed67c19ad4039f6271aec8292138ce6069437475\"}}",
"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-3-q4sb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28478, \"got_angle_revision\": \"3688cb363ccd6ee345f0ee9ae88639a0d118429f\", \"got_dawn_revision\": \"a0b4571546bb8921b6a4f720e24f97d28b7e99c1\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"ed67c19ad4039f6271aec8292138ce6069437475\", \"got_revision_cp\": \"refs/heads/master@{#786173}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"28159ee9c8e385100bb541d73d20dbccc7d5d766\", \"got_v8_revision\": \"e078f1d43a5ef91a701f1686917b6fac5176be85\", \"got_v8_revision_cp\": \"refs/heads/8.6.82@{#1}\", \"got_webrtc_revision\": \"3444a49d77b094c7fa2aade8873288a55ac0b9e5\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31642}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed67c19ad4039f6271aec8292138ce6069437475\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-3-q4sb\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5368-4b51cf5\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594186516949475",
"status": "COMPLETED",
"status_changed_ts": "1594195005038313",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28478",
"builder:Deterministic Linux",
"buildset:commit/git/ed67c19ad4039f6271aec8292138ce6069437475",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed67c19ad4039f6271aec8292138ce6069437475",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040798067693927744",
"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/8875368004503293088/+/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:4d45bd313ab13a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1594195005043153",
"url": "https://ci.chromium.org/b/8875368004503293088",
"utcnow_ts": "1594195005656420"
}
}
[07:56:45.672] Invocation finished in 2h21m40.43873272s with status SUCCEEDED