[18:37:17.222] New invocation is queued and will start shortly
[18:37:18.966] Starting the invocation (attempt 1)
[18:37:19.001] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:37:19.001] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:37:19.001] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9041201840783424400",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0ae9d919fb282ddd2bf54862cdd7ae9064d90366\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9041201840783424400",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"gitiles_ref:refs/heads/master"
]
}
[18:37:20.866] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1593801439126732",
"id": "8875771778125085584",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae9d919fb282ddd2bf54862cdd7ae9064d90366\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1593801439744922",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/17641",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041201840783424400",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8875771778125085584/+/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": "1593801439745050",
"url": "https://ci.chromium.org/b/8875771778125085584",
"utcnow_ts": "1593801440858578"
}
}
[18:37:20.866] Task URL: https://ci.chromium.org/b/8875771778125085584
[18:37:20.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:2:0) after 1m0s
[18:37:24.249] Received PubSub notification, asking Buildbucket for the build status
[18:37:24.321] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:20.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:2:0)
[18:38:20.977] Timer tick, asking Buildbucket for the build status
[18:38:21.251] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:21.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:4:0) after 1m0s
[18:39:21.305] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:4:0)
[18:39:21.305] Timer tick, asking Buildbucket for the build status
[18:39:21.453] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:5:0) after 1m0s
[18:40:21.507] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:5:0)
[18:40:21.507] Timer tick, asking Buildbucket for the build status
[18:40:21.788] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:21.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:6:0) after 1m0s
[18:41:21.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:6:0)
[18:41:21.804] Timer tick, asking Buildbucket for the build status
[18:41:21.942] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:21.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:7:0) after 1m0s
[18:42:22.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:7:0)
[18:42:22.089] Timer tick, asking Buildbucket for the build status
[18:42:22.200] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:22.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:8:0) after 1m0s
[18:43:22.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:8:0)
[18:43:22.256] Timer tick, asking Buildbucket for the build status
[18:43:22.374] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:22.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:9:0) after 1m0s
[18:44:22.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:9:0)
[18:44:22.365] Timer tick, asking Buildbucket for the build status
[18:44:22.502] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:22.502] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:10:0) after 1m0s
[18:45:22.563] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:10:0)
[18:45:22.563] Timer tick, asking Buildbucket for the build status
[18:45:22.752] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:22.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:11:0) after 1m0s
[18:46:22.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:11:0)
[18:46:22.774] Timer tick, asking Buildbucket for the build status
[18:46:22.951] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:22.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:12:0) after 1m0s
[18:47:22.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:12:0)
[18:47:22.956] Timer tick, asking Buildbucket for the build status
[18:47:23.096] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:13:0) after 1m0s
[18:48:23.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:13:0)
[18:48:23.118] Timer tick, asking Buildbucket for the build status
[18:48:23.355] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:23.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:14:0) after 1m0s
[18:49:23.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:14:0)
[18:49:23.392] Timer tick, asking Buildbucket for the build status
[18:49:23.509] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:23.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:15:0) after 1m0s
[18:50:23.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:15:0)
[18:50:23.645] Timer tick, asking Buildbucket for the build status
[18:50:23.852] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:23.853] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:16:0) after 1m0s
[18:51:24.000] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:16:0)
[18:51:24.000] Timer tick, asking Buildbucket for the build status
[18:51:24.387] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:24.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:17:0) after 1m0s
[18:52:24.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:17:0)
[18:52:24.464] Timer tick, asking Buildbucket for the build status
[18:52:24.598] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:24.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:18:0) after 1m0s
[18:53:24.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:18:0)
[18:53:24.682] Timer tick, asking Buildbucket for the build status
[18:53:24.775] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:24.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:19:0) after 1m0s
[18:54:24.879] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:19:0)
[18:54:24.879] Timer tick, asking Buildbucket for the build status
[18:54:25.036] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:25.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:20:0) after 1m0s
[18:55:25.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:20:0)
[18:55:25.117] Timer tick, asking Buildbucket for the build status
[18:55:25.229] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:25.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:21:0) after 1m0s
[18:56:25.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:21:0)
[18:56:25.358] Timer tick, asking Buildbucket for the build status
[18:56:25.488] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:25.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:22:0) after 1m0s
[18:57:25.511] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:22:0)
[18:57:25.511] Timer tick, asking Buildbucket for the build status
[18:57:25.835] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:25.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:23:0) after 1m0s
[18:58:25.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:23:0)
[18:58:25.923] Timer tick, asking Buildbucket for the build status
[18:58:26.017] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:26.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:24:0) after 1m0s
[18:59:26.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:24:0)
[18:59:26.196] Timer tick, asking Buildbucket for the build status
[18:59:26.306] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:26.306] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:25:0) after 1m0s
[19:00:26.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:25:0)
[19:00:26.327] Timer tick, asking Buildbucket for the build status
[19:00:26.439] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:26.439] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:26:0) after 1m0s
[19:01:26.485] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:26:0)
[19:01:26.485] Timer tick, asking Buildbucket for the build status
[19:01:26.783] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:26.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:27:0) after 1m0s
[19:02:26.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:27:0)
[19:02:26.821] Timer tick, asking Buildbucket for the build status
[19:02:27.182] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:27.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:28:0) after 1m0s
[19:03:27.363] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:28:0)
[19:03:27.363] Timer tick, asking Buildbucket for the build status
[19:03:27.470] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:27.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:29:0) after 1m0s
[19:04:27.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:29:0)
[19:04:27.454] Timer tick, asking Buildbucket for the build status
[19:04:27.556] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:27.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:30:0) after 1m0s
[19:05:27.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:30:0)
[19:05:27.662] Timer tick, asking Buildbucket for the build status
[19:05:27.778] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:27.778] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:31:0) after 1m0s
[19:06:27.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:31:0)
[19:06:27.868] Timer tick, asking Buildbucket for the build status
[19:06:28.054] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:28.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:32:0) after 1m0s
[19:07:28.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:32:0)
[19:07:28.122] Timer tick, asking Buildbucket for the build status
[19:07:28.312] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:28.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:33:0) after 1m0s
[19:08:28.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:33:0)
[19:08:28.397] Timer tick, asking Buildbucket for the build status
[19:08:28.496] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:28.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:34:0) after 1m0s
[19:09:28.582] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:34:0)
[19:09:28.582] Timer tick, asking Buildbucket for the build status
[19:09:28.932] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:28.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:35:0) after 1m0s
[19:10:28.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:35:0)
[19:10:28.986] Timer tick, asking Buildbucket for the build status
[19:10:29.099] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:29.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:36:0) after 1m0s
[19:11:29.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:36:0)
[19:11:29.123] Timer tick, asking Buildbucket for the build status
[19:11:29.299] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:29.299] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:37:0) after 1m0s
[19:12:29.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:37:0)
[19:12:29.327] Timer tick, asking Buildbucket for the build status
[19:12:29.790] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:29.790] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:38:0) after 1m0s
[19:13:29.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:38:0)
[19:13:29.806] Timer tick, asking Buildbucket for the build status
[19:13:29.902] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:29.902] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:39:0) after 1m0s
[19:14:29.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:39:0)
[19:14:29.932] Timer tick, asking Buildbucket for the build status
[19:14:30.058] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:30.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:40:0) after 1m0s
[19:15:30.098] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:40:0)
[19:15:30.098] Timer tick, asking Buildbucket for the build status
[19:15:30.337] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:30.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:41:0) after 1m0s
[19:16:30.355] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:41:0)
[19:16:30.355] Timer tick, asking Buildbucket for the build status
[19:16:30.546] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:30.546] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:42:0) after 1m0s
[19:17:30.554] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:42:0)
[19:17:30.554] Timer tick, asking Buildbucket for the build status
[19:17:30.721] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:30.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:43:0) after 1m0s
[19:18:30.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:43:0)
[19:18:30.743] Timer tick, asking Buildbucket for the build status
[19:18:30.859] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:30.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:44:0) after 1m0s
[19:19:30.891] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:44:0)
[19:19:30.891] Timer tick, asking Buildbucket for the build status
[19:19:31.342] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:31.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:45:0) after 1m0s
[19:20:31.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:45:0)
[19:20:31.366] Timer tick, asking Buildbucket for the build status
[19:20:31.505] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:31.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:46:0) after 1m0s
[19:21:31.529] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:46:0)
[19:21:31.529] Timer tick, asking Buildbucket for the build status
[19:21:31.636] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:31.637] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:47:0) after 1m0s
[19:22:31.684] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:47:0)
[19:22:31.684] Timer tick, asking Buildbucket for the build status
[19:22:31.800] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:31.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:48:0) after 1m0s
[19:23:31.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:48:0)
[19:23:31.825] Timer tick, asking Buildbucket for the build status
[19:23:31.952] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:31.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:49:0) after 1m0s
[19:24:31.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:49:0)
[19:24:31.985] Timer tick, asking Buildbucket for the build status
[19:24:32.099] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:32.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:50:0) after 1m0s
[19:25:32.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:50:0)
[19:25:32.122] Timer tick, asking Buildbucket for the build status
[19:25:32.363] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:32.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:51:0) after 1m0s
[19:26:32.427] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:51:0)
[19:26:32.427] Timer tick, asking Buildbucket for the build status
[19:26:32.730] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:32.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:52:0) after 1m0s
[19:27:32.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:52:0)
[19:27:32.751] Timer tick, asking Buildbucket for the build status
[19:27:33.168] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:33.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:53:0) after 1m0s
[19:28:33.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:53:0)
[19:28:33.190] Timer tick, asking Buildbucket for the build status
[19:28:33.293] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:33.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:54:0) after 1m0s
[19:29:33.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:54:0)
[19:29:33.347] Timer tick, asking Buildbucket for the build status
[19:29:33.481] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:33.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:55:0) after 1m0s
[19:30:33.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:55:0)
[19:30:33.503] Timer tick, asking Buildbucket for the build status
[19:30:33.789] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:33.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:56:0) after 1m0s
[19:31:33.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:56:0)
[19:31:33.824] Timer tick, asking Buildbucket for the build status
[19:31:34.029] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:34.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:57:0) after 1m0s
[19:32:34.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:57:0)
[19:32:34.071] Timer tick, asking Buildbucket for the build status
[19:32:34.209] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:34.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:58:0) after 1m0s
[19:33:34.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:58:0)
[19:33:34.191] Timer tick, asking Buildbucket for the build status
[19:33:34.489] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:34.489] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:59:0) after 1m0s
[19:34:34.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:59:0)
[19:34:34.547] Timer tick, asking Buildbucket for the build status
[19:34:34.647] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:34.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:60:0) after 1m0s
[19:35:34.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:60:0)
[19:35:34.708] Timer tick, asking Buildbucket for the build status
[19:35:34.827] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:34.827] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:61:0) after 1m0s
[19:36:34.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:61:0)
[19:36:34.854] Timer tick, asking Buildbucket for the build status
[19:36:34.997] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:34.997] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:62:0) after 1m0s
[19:37:35.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:62:0)
[19:37:35.024] Timer tick, asking Buildbucket for the build status
[19:37:37.234] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:37.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:63:0) after 1m0s
[19:38:37.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:63:0)
[19:38:37.276] Timer tick, asking Buildbucket for the build status
[19:38:37.392] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:37.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:64:0) after 1m0s
[19:39:37.417] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:64:0)
[19:39:37.417] Timer tick, asking Buildbucket for the build status
[19:39:37.482] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:37.482] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:65:0) after 1m0s
[19:40:37.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:65:0)
[19:40:37.515] Timer tick, asking Buildbucket for the build status
[19:40:37.623] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:37.624] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:66:0) after 1m0s
[19:41:37.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:66:0)
[19:41:37.682] Timer tick, asking Buildbucket for the build status
[19:41:37.787] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:37.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:67:0) after 1m0s
[19:42:37.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:67:0)
[19:42:37.806] Timer tick, asking Buildbucket for the build status
[19:42:38.078] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:38.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:68:0) after 1m0s
[19:43:38.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:68:0)
[19:43:38.143] Timer tick, asking Buildbucket for the build status
[19:43:38.247] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:38.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:69:0) after 1m0s
[19:44:38.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:69:0)
[19:44:38.288] Timer tick, asking Buildbucket for the build status
[19:44:38.845] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:38.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:70:0) after 1m0s
[19:45:38.867] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:70:0)
[19:45:38.867] Timer tick, asking Buildbucket for the build status
[19:45:39.532] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:39.532] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:71:0) after 1m0s
[19:46:39.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:71:0)
[19:46:39.556] Timer tick, asking Buildbucket for the build status
[19:46:39.670] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:39.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:72:0) after 1m0s
[19:47:39.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:72:0)
[19:47:39.724] Timer tick, asking Buildbucket for the build status
[19:47:40.921] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:40.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:73:0) after 1m0s
[19:48:41.038] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:73:0)
[19:48:41.038] Timer tick, asking Buildbucket for the build status
[19:48:41.165] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:41.165] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:74:0) after 1m0s
[19:49:41.189] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:74:0)
[19:49:41.189] Timer tick, asking Buildbucket for the build status
[19:49:41.357] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:41.357] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:75:0) after 1m0s
[19:50:41.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:75:0)
[19:50:41.389] Timer tick, asking Buildbucket for the build status
[19:50:41.513] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:41.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:76:0) after 1m0s
[19:51:41.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:76:0)
[19:51:41.718] Timer tick, asking Buildbucket for the build status
[19:51:41.961] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:41.961] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:77:0) after 1m0s
[19:52:41.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:77:0)
[19:52:41.977] Timer tick, asking Buildbucket for the build status
[19:52:42.151] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:42.151] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:78:0) after 1m0s
[19:53:42.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:78:0)
[19:53:42.173] Timer tick, asking Buildbucket for the build status
[19:53:42.381] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:42.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:79:0) after 1m0s
[19:54:42.433] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:79:0)
[19:54:42.433] Timer tick, asking Buildbucket for the build status
[19:54:42.694] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:42.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:80:0) after 1m0s
[19:55:42.750] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:80:0)
[19:55:42.750] Timer tick, asking Buildbucket for the build status
[19:55:42.857] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:42.857] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:81:0) after 1m0s
[19:56:42.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:81:0)
[19:56:42.875] Timer tick, asking Buildbucket for the build status
[19:56:43.063] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:43.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:82:0) after 1m0s
[19:57:43.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:82:0)
[19:57:43.103] Timer tick, asking Buildbucket for the build status
[19:57:44.384] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:83:0) after 1m0s
[19:58:44.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:83:0)
[19:58:44.449] Timer tick, asking Buildbucket for the build status
[19:58:45.619] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:45.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:84:0) after 1m0s
[19:59:45.658] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:84:0)
[19:59:45.658] Timer tick, asking Buildbucket for the build status
[19:59:45.846] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:45.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:85:0) after 1m0s
[20:00:45.849] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:85:0)
[20:00:45.849] Timer tick, asking Buildbucket for the build status
[20:00:45.953] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:45.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:86:0) after 1m0s
[20:01:45.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:86:0)
[20:01:45.976] Timer tick, asking Buildbucket for the build status
[20:01:46.081] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:46.081] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:87:0) after 1m0s
[20:02:46.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:87:0)
[20:02:46.093] Timer tick, asking Buildbucket for the build status
[20:02:47.097] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:47.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:88:0) after 1m0s
[20:03:47.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:88:0)
[20:03:47.127] Timer tick, asking Buildbucket for the build status
[20:03:47.310] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:47.310] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:89:0) after 1m0s
[20:04:47.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:89:0)
[20:04:47.352] Timer tick, asking Buildbucket for the build status
[20:04:47.464] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:47.464] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:90:0) after 1m0s
[20:05:47.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:90:0)
[20:05:47.505] Timer tick, asking Buildbucket for the build status
[20:05:47.817] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:47.817] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:91:0) after 1m0s
[20:06:47.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:91:0)
[20:06:47.790] Timer tick, asking Buildbucket for the build status
[20:06:48.283] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:48.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:92:0) after 1m0s
[20:07:48.287] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:92:0)
[20:07:48.287] Timer tick, asking Buildbucket for the build status
[20:07:48.988] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:48.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:93:0) after 1m0s
[20:08:49.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:93:0)
[20:08:49.094] Timer tick, asking Buildbucket for the build status
[20:08:49.236] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:49.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:94:0) after 1m0s
[20:09:49.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:94:0)
[20:09:49.296] Timer tick, asking Buildbucket for the build status
[20:09:49.436] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:49.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:95:0) after 1m0s
[20:10:49.460] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:95:0)
[20:10:49.460] Timer tick, asking Buildbucket for the build status
[20:10:49.571] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:49.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:96:0) after 1m0s
[20:11:49.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:96:0)
[20:11:49.679] Timer tick, asking Buildbucket for the build status
[20:11:49.776] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:49.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:97:0) after 1m0s
[20:12:49.798] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:97:0)
[20:12:49.798] Timer tick, asking Buildbucket for the build status
[20:12:49.947] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:98:0) after 1m0s
[20:13:50.007] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:98:0)
[20:13:50.007] Timer tick, asking Buildbucket for the build status
[20:13:50.121] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:50.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:99:0) after 1m0s
[20:14:50.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:99:0)
[20:14:50.143] Timer tick, asking Buildbucket for the build status
[20:14:50.597] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:50.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:100:0) after 1m0s
[20:15:50.674] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:100:0)
[20:15:50.674] Timer tick, asking Buildbucket for the build status
[20:15:51.048] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:51.048] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:101:0) after 1m0s
[20:16:51.090] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:101:0)
[20:16:51.090] Timer tick, asking Buildbucket for the build status
[20:16:51.247] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:51.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:102:0) after 1m0s
[20:17:51.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:102:0)
[20:17:51.269] Timer tick, asking Buildbucket for the build status
[20:17:52.283] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:52.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:103:0) after 1m0s
[20:18:52.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:103:0)
[20:18:52.277] Timer tick, asking Buildbucket for the build status
[20:18:52.384] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:52.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:104:0) after 1m0s
[20:19:52.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:104:0)
[20:19:52.413] Timer tick, asking Buildbucket for the build status
[20:19:52.659] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:52.659] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:105:0) after 1m0s
[20:20:52.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:105:0)
[20:20:52.745] Timer tick, asking Buildbucket for the build status
[20:20:52.974] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:52.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:106:0) after 1m0s
[20:21:52.983] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:106:0)
[20:21:52.983] Timer tick, asking Buildbucket for the build status
[20:21:53.091] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:53.091] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:107:0) after 1m0s
[20:22:53.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:107:0)
[20:22:53.156] Timer tick, asking Buildbucket for the build status
[20:22:53.382] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:53.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:108:0) after 1m0s
[20:23:53.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:108:0)
[20:23:53.407] Timer tick, asking Buildbucket for the build status
[20:23:53.512] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:53.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:109:0) after 1m0s
[20:24:53.533] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:109:0)
[20:24:53.533] Timer tick, asking Buildbucket for the build status
[20:24:53.669] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:53.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:110:0) after 1m0s
[20:25:53.704] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:110:0)
[20:25:53.704] Timer tick, asking Buildbucket for the build status
[20:25:53.805] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:53.805] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:111:0) after 1m0s
[20:26:53.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:111:0)
[20:26:53.832] Timer tick, asking Buildbucket for the build status
[20:26:53.955] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:53.955] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:112:0) after 1m0s
[20:27:53.997] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:112:0)
[20:27:53.997] Timer tick, asking Buildbucket for the build status
[20:27:54.195] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:54.195] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:113:0) after 1m0s
[20:28:54.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:113:0)
[20:28:54.222] Timer tick, asking Buildbucket for the build status
[20:28:54.355] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:54.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:114:0) after 1m0s
[20:29:54.419] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:114:0)
[20:29:54.419] Timer tick, asking Buildbucket for the build status
[20:29:54.524] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:54.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:115:0) after 1m0s
[20:30:54.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:115:0)
[20:30:54.521] Timer tick, asking Buildbucket for the build status
[20:30:54.628] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:54.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:116:0) after 1m0s
[20:31:54.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:116:0)
[20:31:54.718] Timer tick, asking Buildbucket for the build status
[20:31:54.943] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:54.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:117:0) after 1m0s
[20:32:54.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:117:0)
[20:32:54.986] Timer tick, asking Buildbucket for the build status
[20:32:55.444] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:55.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:118:0) after 1m0s
[20:33:55.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:118:0)
[20:33:55.543] Timer tick, asking Buildbucket for the build status
[20:33:55.653] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:55.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:119:0) after 1m0s
[20:34:55.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:119:0)
[20:34:55.714] Timer tick, asking Buildbucket for the build status
[20:34:55.842] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:55.842] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:120:0) after 1m0s
[20:35:55.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:120:0)
[20:35:55.866] Timer tick, asking Buildbucket for the build status
[20:35:56.024] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:56.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:121:0) after 1m0s
[20:36:56.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:121:0)
[20:36:56.064] Timer tick, asking Buildbucket for the build status
[20:36:56.210] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:56.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:122:0) after 1m0s
[20:37:56.288] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:122:0)
[20:37:56.288] Timer tick, asking Buildbucket for the build status
[20:37:56.501] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:56.501] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:123:0) after 1m0s
[20:38:56.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:123:0)
[20:38:56.576] Timer tick, asking Buildbucket for the build status
[20:38:56.859] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:56.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:124:0) after 1m0s
[20:39:56.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:124:0)
[20:39:56.920] Timer tick, asking Buildbucket for the build status
[20:39:57.102] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:57.102] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:125:0) after 1m0s
[20:40:57.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:125:0)
[20:40:57.126] Timer tick, asking Buildbucket for the build status
[20:40:57.704] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:57.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:126:0) after 1m0s
[20:41:57.842] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:126:0)
[20:41:57.842] Timer tick, asking Buildbucket for the build status
[20:41:57.979] Build 8875771778125085584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:57.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9041201840783424400:127:0) after 1m0s
[20:42:10.575] Received PubSub notification, asking Buildbucket for the build status
[20:42:10.638] Build 8875771778125085584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[20:42:10.638] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1593808929439904",
"created_by": "project:chromium",
"created_ts": "1593801439126732",
"id": "8875771778125085584",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae9d919fb282ddd2bf54862cdd7ae9064d90366\"}}",
"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-32-19-dnjr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 17641, \"got_angle_revision\": \"5fec8ecf9cf43f8664d7b8355ffc092b6eb447cb\", \"got_dawn_revision\": \"59ccb1f6de17ac15a45374acd4cef997e190e8f8\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"0ae9d919fb282ddd2bf54862cdd7ae9064d90366\", \"got_revision_cp\": \"refs/heads/master@{#785102}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"3121585acce20f5cc2074088563e3c1a076b8e48\", \"got_v8_revision\": \"58e5e4820cbc51f6278a100bca43346c9cdf9eb1\", \"got_v8_revision_cp\": \"refs/heads/8.6.52@{#1}\", \"got_webrtc_revision\": \"1e10a6156405f1c9b4c432c57a955f70642ccfc8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31617}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae9d919fb282ddd2bf54862cdd7ae9064d90366\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-19-dnjr\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5320-752003c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1593801443542478",
"status": "COMPLETED",
"status_changed_ts": "1593808929907317",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/17641",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae9d919fb282ddd2bf54862cdd7ae9064d90366",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9041201840783424400",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8875771778125085584/+/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:4d2ec987936d0310",
"user_agent:luci-scheduler"
],
"updated_ts": "1593808929955862",
"url": "https://ci.chromium.org/b/8875771778125085584",
"utcnow_ts": "1593808930629157"
}
}
[20:42:10.639] Invocation finished in 2h4m53.431993662s with status SUCCEEDED