[20:41:18.256] New invocation is queued and will start shortly
[20:41:19.384] Starting the invocation (attempt 1)
[20:41:19.428] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:41:19.428] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:41:19.428] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050163137984080768",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1081de2f117d65e63eb960b6086a03a9b4148224\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9050163137984080768",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/1081de2f117d65e63eb960b6086a03a9b4148224",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1081de2f117d65e63eb960b6086a03a9b4148224",
"gitiles_ref:refs/heads/master"
]
}
[20:41:20.251] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585255279511366",
"id": "8884733075989392544",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1081de2f117d65e63eb960b6086a03a9b4148224\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585255280075445",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27309",
"builder:Deterministic Linux",
"buildset:commit/git/1081de2f117d65e63eb960b6086a03a9b4148224",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1081de2f117d65e63eb960b6086a03a9b4148224",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050163137984080768",
"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/8884733075989392544/+/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": "1585255280075607",
"url": "https://ci.chromium.org/b/8884733075989392544",
"utcnow_ts": "1585255280242298"
}
}
[20:41:20.251] Task URL: https://ci.chromium.org/b/8884733075989392544
[20:41:20.251] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:2:0) after 1m0s
[20:42:20.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:2:0)
[20:42:20.321] Timer tick, asking Buildbucket for the build status
[20:42:20.523] Build 8884733075989392544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:42:20.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:3:0) after 1m0s
[20:43:20.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:3:0)
[20:43:20.717] Timer tick, asking Buildbucket for the build status
[20:43:21.191] Build 8884733075989392544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:43:21.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:4:0) after 1m0s
[20:44:21.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:4:0)
[20:44:21.385] Timer tick, asking Buildbucket for the build status
[20:44:21.639] Build 8884733075989392544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:44:21.639] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:5:0) after 1m0s
[20:45:21.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:5:0)
[20:45:21.744] Timer tick, asking Buildbucket for the build status
[20:45:22.422] Build 8884733075989392544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:45:22.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:6:0) after 1m0s
[20:46:11.916] Received PubSub notification, asking Buildbucket for the build status
[20:46:12.181] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:22.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:6:0)
[20:46:22.503] Timer tick, asking Buildbucket for the build status
[20:46:22.675] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:22.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:8:0) after 1m0s
[20:47:22.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:8:0)
[20:47:22.726] Timer tick, asking Buildbucket for the build status
[20:47:23.046] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:9:0) after 1m0s
[20:48:23.356] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:9:0)
[20:48:23.356] Timer tick, asking Buildbucket for the build status
[20:48:23.641] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:23.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:10:0) after 1m0s
[20:49:23.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:10:0)
[20:49:23.695] Timer tick, asking Buildbucket for the build status
[20:49:23.890] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:23.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:11:0) after 1m0s
[20:50:24.020] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:11:0)
[20:50:24.020] Timer tick, asking Buildbucket for the build status
[20:50:24.162] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:24.162] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:12:0) after 1m0s
[20:51:24.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:12:0)
[20:51:24.364] Timer tick, asking Buildbucket for the build status
[20:51:24.555] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:24.555] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:13:0) after 1m0s
[20:52:24.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:13:0)
[20:52:24.581] Timer tick, asking Buildbucket for the build status
[20:52:25.219] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:25.219] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:14:0) after 1m0s
[20:53:25.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:14:0)
[20:53:25.228] Timer tick, asking Buildbucket for the build status
[20:53:27.673] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:27.674] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:15:0) after 1m0s
[20:54:27.734] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:15:0)
[20:54:27.734] Timer tick, asking Buildbucket for the build status
[20:54:28.646] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:28.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:16:0) after 1m0s
[20:55:28.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:16:0)
[20:55:28.820] Timer tick, asking Buildbucket for the build status
[20:55:28.989] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:28.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:17:0) after 1m0s
[20:56:29.079] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:17:0)
[20:56:29.079] Timer tick, asking Buildbucket for the build status
[20:56:29.314] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:29.314] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:18:0) after 1m0s
[20:57:29.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:18:0)
[20:57:29.430] Timer tick, asking Buildbucket for the build status
[20:57:30.906] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:30.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:19:0) after 1m0s
[20:58:30.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:19:0)
[20:58:30.930] Timer tick, asking Buildbucket for the build status
[20:58:31.297] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:31.297] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:20:0) after 1m0s
[20:59:31.400] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:20:0)
[20:59:31.400] Timer tick, asking Buildbucket for the build status
[20:59:31.741] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:31.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:21:0) after 1m0s
[21:00:31.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:21:0)
[21:00:31.844] Timer tick, asking Buildbucket for the build status
[21:00:32.046] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:22:0) after 1m0s
[21:01:32.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:22:0)
[21:01:32.119] Timer tick, asking Buildbucket for the build status
[21:01:32.426] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:32.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:23:0) after 1m0s
[21:02:32.562] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:23:0)
[21:02:32.562] Timer tick, asking Buildbucket for the build status
[21:02:33.307] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:33.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:24:0) after 1m0s
[21:03:33.338] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:24:0)
[21:03:33.338] Timer tick, asking Buildbucket for the build status
[21:03:33.455] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:33.455] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:25:0) after 1m0s
[21:04:33.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:25:0)
[21:04:33.642] Timer tick, asking Buildbucket for the build status
[21:04:33.786] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:33.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:26:0) after 1m0s
[21:05:33.882] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:26:0)
[21:05:33.882] Timer tick, asking Buildbucket for the build status
[21:05:33.989] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:33.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:27:0) after 1m0s
[21:06:34.226] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:27:0)
[21:06:34.226] Timer tick, asking Buildbucket for the build status
[21:06:35.710] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:35.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:28:0) after 1m0s
[21:07:35.736] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:28:0)
[21:07:35.736] Timer tick, asking Buildbucket for the build status
[21:07:36.261] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:36.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:29:0) after 1m0s
[21:08:36.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:29:0)
[21:08:36.487] Timer tick, asking Buildbucket for the build status
[21:08:36.727] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:36.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:30:0) after 1m0s
[21:09:36.835] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:30:0)
[21:09:36.835] Timer tick, asking Buildbucket for the build status
[21:09:36.990] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:36.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:31:0) after 1m0s
[21:10:37.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:31:0)
[21:10:37.027] Timer tick, asking Buildbucket for the build status
[21:10:37.594] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:37.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:32:0) after 1m0s
[21:11:37.652] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:32:0)
[21:11:37.652] Timer tick, asking Buildbucket for the build status
[21:11:37.829] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:37.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:33:0) after 1m0s
[21:12:37.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:33:0)
[21:12:37.853] Timer tick, asking Buildbucket for the build status
[21:12:38.531] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:38.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:34:0) after 1m0s
[21:13:38.549] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:34:0)
[21:13:38.549] Timer tick, asking Buildbucket for the build status
[21:13:38.677] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:38.677] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:35:0) after 1m0s
[21:14:39.071] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:35:0)
[21:14:39.071] Timer tick, asking Buildbucket for the build status
[21:14:39.308] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:36:0) after 1m0s
[21:15:39.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:36:0)
[21:15:39.351] Timer tick, asking Buildbucket for the build status
[21:15:39.522] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:39.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:37:0) after 1m0s
[21:16:39.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:37:0)
[21:16:39.719] Timer tick, asking Buildbucket for the build status
[21:16:39.819] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:38:0) after 1m0s
[21:17:39.939] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:38:0)
[21:17:39.939] Timer tick, asking Buildbucket for the build status
[21:17:40.049] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.049] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:39:0) after 1m0s
[21:18:40.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:39:0)
[21:18:40.442] Timer tick, asking Buildbucket for the build status
[21:18:40.681] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:40.681] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:40:0) after 1m0s
[21:19:40.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:40:0)
[21:19:40.666] Timer tick, asking Buildbucket for the build status
[21:19:40.758] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:40.758] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:41:0) after 1m0s
[21:20:40.966] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:41:0)
[21:20:40.966] Timer tick, asking Buildbucket for the build status
[21:20:41.145] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:41.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:42:0) after 1m0s
[21:21:41.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:42:0)
[21:21:41.273] Timer tick, asking Buildbucket for the build status
[21:21:41.964] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:41.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:43:0) after 1m0s
[21:22:42.059] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:43:0)
[21:22:42.059] Timer tick, asking Buildbucket for the build status
[21:22:43.283] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:44:0) after 1m0s
[21:23:43.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:44:0)
[21:23:43.336] Timer tick, asking Buildbucket for the build status
[21:23:43.530] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:43.530] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:45:0) after 1m0s
[21:24:43.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:45:0)
[21:24:43.586] Timer tick, asking Buildbucket for the build status
[21:24:44.056] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:44.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:46:0) after 1m0s
[21:25:44.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:46:0)
[21:25:44.050] Timer tick, asking Buildbucket for the build status
[21:25:44.496] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:44.496] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:47:0) after 1m0s
[21:26:44.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:47:0)
[21:26:44.557] Timer tick, asking Buildbucket for the build status
[21:26:44.745] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:44.745] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:48:0) after 1m0s
[21:27:44.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:48:0)
[21:27:44.766] Timer tick, asking Buildbucket for the build status
[21:27:45.777] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:49:0) after 1m0s
[21:28:45.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:49:0)
[21:28:45.847] Timer tick, asking Buildbucket for the build status
[21:28:47.337] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:47.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:50:0) after 1m0s
[21:29:47.387] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:50:0)
[21:29:47.387] Timer tick, asking Buildbucket for the build status
[21:29:47.601] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:47.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:51:0) after 1m0s
[21:30:47.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:51:0)
[21:30:47.722] Timer tick, asking Buildbucket for the build status
[21:30:47.875] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:47.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:52:0) after 1m0s
[21:31:47.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:52:0)
[21:31:47.979] Timer tick, asking Buildbucket for the build status
[21:31:48.326] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:48.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:53:0) after 1m0s
[21:32:48.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:53:0)
[21:32:48.394] Timer tick, asking Buildbucket for the build status
[21:32:49.088] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:49.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:54:0) after 1m0s
[21:33:49.152] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:54:0)
[21:33:49.152] Timer tick, asking Buildbucket for the build status
[21:33:49.294] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:49.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:55:0) after 1m0s
[21:34:49.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:55:0)
[21:34:49.328] Timer tick, asking Buildbucket for the build status
[21:34:49.484] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:49.484] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:56:0) after 1m0s
[21:35:49.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:56:0)
[21:35:49.584] Timer tick, asking Buildbucket for the build status
[21:35:49.755] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:49.755] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:57:0) after 1m0s
[21:36:49.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:57:0)
[21:36:49.782] Timer tick, asking Buildbucket for the build status
[21:36:49.890] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:49.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:58:0) after 1m0s
[21:37:49.975] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:58:0)
[21:37:49.975] Timer tick, asking Buildbucket for the build status
[21:37:50.174] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:50.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:59:0) after 1m0s
[21:38:50.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:59:0)
[21:38:50.260] Timer tick, asking Buildbucket for the build status
[21:38:51.541] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:51.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:60:0) after 1m0s
[21:39:51.809] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:60:0)
[21:39:51.809] Timer tick, asking Buildbucket for the build status
[21:39:52.057] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:61:0) after 1m0s
[21:40:52.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:61:0)
[21:40:52.137] Timer tick, asking Buildbucket for the build status
[21:40:52.253] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:52.253] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:62:0) after 1m0s
[21:41:52.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:62:0)
[21:41:52.470] Timer tick, asking Buildbucket for the build status
[21:41:52.603] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:52.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:63:0) after 1m0s
[21:42:52.709] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:63:0)
[21:42:52.709] Timer tick, asking Buildbucket for the build status
[21:42:52.815] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:52.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:64:0) after 1m0s
[21:43:52.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:64:0)
[21:43:52.943] Timer tick, asking Buildbucket for the build status
[21:43:53.384] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:65:0) after 1m0s
[21:44:53.597] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:65:0)
[21:44:53.597] Timer tick, asking Buildbucket for the build status
[21:44:53.753] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:53.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:66:0) after 1m0s
[21:45:54.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:66:0)
[21:45:54.184] Timer tick, asking Buildbucket for the build status
[21:45:54.582] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:54.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:67:0) after 1m0s
[21:46:54.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:67:0)
[21:46:54.692] Timer tick, asking Buildbucket for the build status
[21:46:54.822] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:54.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:68:0) after 1m0s
[21:47:54.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:68:0)
[21:47:54.940] Timer tick, asking Buildbucket for the build status
[21:47:55.109] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:69:0) after 1m0s
[21:48:55.161] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:69:0)
[21:48:55.161] Timer tick, asking Buildbucket for the build status
[21:48:55.387] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:55.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:70:0) after 1m0s
[21:49:55.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:70:0)
[21:49:55.402] Timer tick, asking Buildbucket for the build status
[21:49:55.864] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:55.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:71:0) after 1m0s
[21:50:56.017] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:71:0)
[21:50:56.017] Timer tick, asking Buildbucket for the build status
[21:50:56.243] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:56.243] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:72:0) after 1m0s
[21:51:56.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:72:0)
[21:51:56.352] Timer tick, asking Buildbucket for the build status
[21:51:56.495] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:56.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:73:0) after 1m0s
[21:52:56.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:73:0)
[21:52:56.527] Timer tick, asking Buildbucket for the build status
[21:52:56.763] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:56.763] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:74:0) after 1m0s
[21:53:56.883] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:74:0)
[21:53:56.883] Timer tick, asking Buildbucket for the build status
[21:53:57.106] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:57.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:75:0) after 1m0s
[21:54:57.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:75:0)
[21:54:57.235] Timer tick, asking Buildbucket for the build status
[21:54:57.630] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:57.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:76:0) after 1m0s
[21:55:57.717] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:76:0)
[21:55:57.717] Timer tick, asking Buildbucket for the build status
[21:55:57.866] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:57.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:77:0) after 1m0s
[21:56:57.913] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:77:0)
[21:56:57.913] Timer tick, asking Buildbucket for the build status
[21:56:58.276] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:58.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:78:0) after 1m0s
[21:57:58.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:78:0)
[21:57:58.335] Timer tick, asking Buildbucket for the build status
[21:57:58.495] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:58.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:79:0) after 1m0s
[21:58:58.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:79:0)
[21:58:58.861] Timer tick, asking Buildbucket for the build status
[21:58:59.032] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:59.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:80:0) after 1m0s
[21:59:59.496] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:80:0)
[21:59:59.496] Timer tick, asking Buildbucket for the build status
[21:59:59.666] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:59.666] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:81:0) after 1m0s
[22:00:59.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:81:0)
[22:00:59.814] Timer tick, asking Buildbucket for the build status
[22:01:00.144] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:00.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:82:0) after 1m0s
[22:02:00.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:82:0)
[22:02:00.421] Timer tick, asking Buildbucket for the build status
[22:02:00.876] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:00.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:83:0) after 1m0s
[22:03:01.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:83:0)
[22:03:01.094] Timer tick, asking Buildbucket for the build status
[22:03:01.193] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:01.193] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:84:0) after 1m0s
[22:04:01.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:84:0)
[22:04:01.194] Timer tick, asking Buildbucket for the build status
[22:04:01.332] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:01.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:85:0) after 1m0s
[22:05:02.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:85:0)
[22:05:02.127] Timer tick, asking Buildbucket for the build status
[22:05:02.237] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:02.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:86:0) after 1m0s
[22:06:02.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:86:0)
[22:06:02.399] Timer tick, asking Buildbucket for the build status
[22:06:02.715] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:02.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:87:0) after 1m0s
[22:07:02.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:87:0)
[22:07:02.740] Timer tick, asking Buildbucket for the build status
[22:07:03.344] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:03.344] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:88:0) after 1m0s
[22:08:03.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:88:0)
[22:08:03.459] Timer tick, asking Buildbucket for the build status
[22:08:03.742] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:03.742] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:89:0) after 1m0s
[22:09:03.759] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:89:0)
[22:09:03.759] Timer tick, asking Buildbucket for the build status
[22:09:03.938] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:03.938] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:90:0) after 1m0s
[22:10:03.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:90:0)
[22:10:03.990] Timer tick, asking Buildbucket for the build status
[22:10:04.380] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:91:0) after 1m0s
[22:11:04.449] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:91:0)
[22:11:04.449] Timer tick, asking Buildbucket for the build status
[22:11:04.725] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:04.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:92:0) after 1m0s
[22:12:04.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:92:0)
[22:12:04.754] Timer tick, asking Buildbucket for the build status
[22:12:05.264] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:05.264] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:93:0) after 1m0s
[22:13:05.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:93:0)
[22:13:05.295] Timer tick, asking Buildbucket for the build status
[22:13:05.689] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:05.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:94:0) after 1m0s
[22:14:05.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:94:0)
[22:14:05.726] Timer tick, asking Buildbucket for the build status
[22:14:05.904] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:05.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:95:0) after 1m0s
[22:15:05.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:95:0)
[22:15:05.914] Timer tick, asking Buildbucket for the build status
[22:15:06.083] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:96:0) after 1m0s
[22:16:06.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:96:0)
[22:16:06.182] Timer tick, asking Buildbucket for the build status
[22:16:06.442] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:06.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:97:0) after 1m0s
[22:17:06.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:97:0)
[22:17:06.505] Timer tick, asking Buildbucket for the build status
[22:17:07.045] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:07.045] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:98:0) after 1m0s
[22:18:07.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:98:0)
[22:18:07.037] Timer tick, asking Buildbucket for the build status
[22:18:08.859] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:08.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:99:0) after 1m0s
[22:19:08.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:99:0)
[22:19:08.910] Timer tick, asking Buildbucket for the build status
[22:19:09.057] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:09.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:100:0) after 1m0s
[22:20:09.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:100:0)
[22:20:09.137] Timer tick, asking Buildbucket for the build status
[22:20:09.280] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:09.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:101:0) after 1m0s
[22:21:09.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:101:0)
[22:21:09.339] Timer tick, asking Buildbucket for the build status
[22:21:09.446] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:09.446] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:102:0) after 1m0s
[22:22:09.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:102:0)
[22:22:09.482] Timer tick, asking Buildbucket for the build status
[22:22:09.581] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:09.581] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:103:0) after 1m0s
[22:23:09.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:103:0)
[22:23:09.649] Timer tick, asking Buildbucket for the build status
[22:23:09.952] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:09.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:104:0) after 1m0s
[22:24:10.005] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:104:0)
[22:24:10.005] Timer tick, asking Buildbucket for the build status
[22:24:10.177] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:10.177] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:105:0) after 1m0s
[22:25:10.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:105:0)
[22:25:10.267] Timer tick, asking Buildbucket for the build status
[22:25:10.384] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:10.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:106:0) after 1m0s
[22:26:10.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:106:0)
[22:26:10.535] Timer tick, asking Buildbucket for the build status
[22:26:10.901] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:10.901] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:107:0) after 1m0s
[22:27:10.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:107:0)
[22:27:10.989] Timer tick, asking Buildbucket for the build status
[22:27:11.152] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:11.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:108:0) after 1m0s
[22:28:11.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:108:0)
[22:28:11.180] Timer tick, asking Buildbucket for the build status
[22:28:11.394] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:11.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:109:0) after 1m0s
[22:29:11.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:109:0)
[22:29:11.385] Timer tick, asking Buildbucket for the build status
[22:29:11.611] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:11.611] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:110:0) after 1m0s
[22:30:11.606] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:110:0)
[22:30:11.606] Timer tick, asking Buildbucket for the build status
[22:30:11.871] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:11.871] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:111:0) after 1m0s
[22:31:11.897] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:111:0)
[22:31:11.897] Timer tick, asking Buildbucket for the build status
[22:31:12.150] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:12.150] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:112:0) after 1m0s
[22:32:12.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:112:0)
[22:32:12.199] Timer tick, asking Buildbucket for the build status
[22:32:13.212] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:13.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:113:0) after 1m0s
[22:33:13.275] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:113:0)
[22:33:13.275] Timer tick, asking Buildbucket for the build status
[22:33:13.504] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:13.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:114:0) after 1m0s
[22:34:13.564] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:114:0)
[22:34:13.564] Timer tick, asking Buildbucket for the build status
[22:34:15.092] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:15.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:115:0) after 1m0s
[22:35:15.093] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:115:0)
[22:35:15.093] Timer tick, asking Buildbucket for the build status
[22:35:15.232] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:15.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:116:0) after 1m0s
[22:36:15.260] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:116:0)
[22:36:15.260] Timer tick, asking Buildbucket for the build status
[22:36:15.561] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:15.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:117:0) after 1m0s
[22:37:15.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:117:0)
[22:37:15.643] Timer tick, asking Buildbucket for the build status
[22:37:16.321] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:16.321] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:118:0) after 1m0s
[22:38:16.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:118:0)
[22:38:16.408] Timer tick, asking Buildbucket for the build status
[22:38:17.290] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:17.290] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:119:0) after 1m0s
[22:39:17.396] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:119:0)
[22:39:17.396] Timer tick, asking Buildbucket for the build status
[22:39:17.495] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:17.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:120:0) after 1m0s
[22:40:17.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:120:0)
[22:40:17.528] Timer tick, asking Buildbucket for the build status
[22:40:18.419] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:18.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:121:0) after 1m0s
[22:41:18.472] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:121:0)
[22:41:18.472] Timer tick, asking Buildbucket for the build status
[22:41:18.561] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:18.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:122:0) after 1m0s
[22:42:18.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:122:0)
[22:42:18.739] Timer tick, asking Buildbucket for the build status
[22:42:18.997] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:18.997] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:123:0) after 1m0s
[22:43:19.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:123:0)
[22:43:19.035] Timer tick, asking Buildbucket for the build status
[22:43:20.391] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:20.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:124:0) after 1m0s
[22:44:20.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:124:0)
[22:44:20.476] Timer tick, asking Buildbucket for the build status
[22:44:20.943] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:20.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:125:0) after 1m0s
[22:45:20.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:125:0)
[22:45:20.967] Timer tick, asking Buildbucket for the build status
[22:45:21.169] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:21.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:126:0) after 1m0s
[22:46:21.194] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:126:0)
[22:46:21.194] Timer tick, asking Buildbucket for the build status
[22:46:21.335] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:21.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:127:0) after 1m0s
[22:47:21.367] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:127:0)
[22:47:21.367] Timer tick, asking Buildbucket for the build status
[22:47:22.046] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:22.046] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:128:0) after 1m0s
[22:48:22.158] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:128:0)
[22:48:22.158] Timer tick, asking Buildbucket for the build status
[22:48:22.542] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:22.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:129:0) after 1m0s
[22:49:22.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:129:0)
[22:49:22.521] Timer tick, asking Buildbucket for the build status
[22:49:23.849] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:23.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:130:0) after 1m0s
[22:50:23.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:130:0)
[22:50:23.995] Timer tick, asking Buildbucket for the build status
[22:50:24.137] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:24.137] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:131:0) after 1m0s
[22:51:24.247] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:131:0)
[22:51:24.247] Timer tick, asking Buildbucket for the build status
[22:51:24.656] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:24.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:132:0) after 1m0s
[22:52:24.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:132:0)
[22:52:24.716] Timer tick, asking Buildbucket for the build status
[22:52:24.908] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:24.908] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:133:0) after 1m0s
[22:53:24.969] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:133:0)
[22:53:24.969] Timer tick, asking Buildbucket for the build status
[22:53:25.445] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:25.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:134:0) after 1m0s
[22:54:25.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:134:0)
[22:54:25.462] Timer tick, asking Buildbucket for the build status
[22:54:25.617] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:25.617] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:135:0) after 1m0s
[22:55:25.615] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:135:0)
[22:55:25.615] Timer tick, asking Buildbucket for the build status
[22:55:26.362] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:26.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:136:0) after 1m0s
[22:56:26.463] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:136:0)
[22:56:26.463] Timer tick, asking Buildbucket for the build status
[22:56:28.442] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:28.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:137:0) after 1m0s
[22:57:28.501] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:137:0)
[22:57:28.501] Timer tick, asking Buildbucket for the build status
[22:57:28.619] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:28.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:138:0) after 1m0s
[22:58:28.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:138:0)
[22:58:28.656] Timer tick, asking Buildbucket for the build status
[22:58:29.000] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:29.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:139:0) after 1m0s
[22:59:28.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:139:0)
[22:59:28.979] Timer tick, asking Buildbucket for the build status
[22:59:36.241] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:36.241] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:140:0) after 1m0s
[23:00:36.397] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:140:0)
[23:00:36.397] Timer tick, asking Buildbucket for the build status
[23:00:36.725] Build 8884733075989392544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:36.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9050163137984080768:141:0) after 1m0s
[23:00:49.562] Received PubSub notification, asking Buildbucket for the build status
[23:00:51.251] Build 8884733075989392544: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:00:51.251] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585263647339786",
"created_by": "project:chromium",
"created_ts": "1585255279511366",
"id": "8884733075989392544",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1081de2f117d65e63eb960b6086a03a9b4148224\"}}",
"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-103-lf9k\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 27309, \"got_angle_revision\": \"bf6b8d4a16ae13243fee8718e98c8658f4fab218\", \"got_dawn_revision\": \"0847cb4637366d15efdb09c57d9b53ea720587fb\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"1081de2f117d65e63eb960b6086a03a9b4148224\", \"got_revision_cp\": \"refs/heads/master@{#753755}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"37457d5e18268b49db71fbbdfdd110b90094193e\", \"got_v8_revision\": \"5e04fbf91e5dad673d29a119904c1b068cdd7996\", \"got_v8_revision_cp\": \"refs/heads/8.3.84@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1081de2f117d65e63eb960b6086a03a9b4148224\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3ebf4dd509a5805e98d79f047f39cac1c13d897e075c42798b95fb1279fe5d7c_v2\", \"builder_69f5bab4a885266166e099964d6d1498f6d3761c92bc1d5b083a29cb822fe90c_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_v2\", \"builder_fbb3d50a702ddd064319c35d96f4b89f6e7a29ba4c11145a49be75e11fea82c5_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-103-lf9k\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585255569087471",
"status": "COMPLETED",
"status_changed_ts": "1585263649198880",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/27309",
"builder:Deterministic Linux",
"buildset:commit/git/1081de2f117d65e63eb960b6086a03a9b4148224",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1081de2f117d65e63eb960b6086a03a9b4148224",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050163137984080768",
"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/8884733075989392544/+/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:4b3165942500b510",
"user_agent:luci-scheduler"
],
"updated_ts": "1585263649220801",
"url": "https://ci.chromium.org/b/8884733075989392544",
"utcnow_ts": "1585263651224223"
}
}
[23:00:51.252] Invocation finished in 2h19m33.026697931s with status SUCCEEDED