[20:06:14.521] New invocation is queued and will start shortly
[20:06:15.689] Starting the invocation (attempt 1)
[20:06:15.724] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:06:15.724] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:06:15.725] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9075894882352784096",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"221c6f3dad0073f21079673f7b05a5ac88e13a95\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9075894882352784096",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"gitiles_ref:refs/heads/master"
]
}
[20:06:17.923] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1560715576162577",
"id": "8910464819968679920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"221c6f3dad0073f21079673f7b05a5ac88e13a95\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560715576935624",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23755",
"builder:Deterministic Linux",
"buildset:commit/git/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075894882352784096",
"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/8910464819968679920/+/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": "1560715576935744",
"url": "https://ci.chromium.org/b/8910464819968679920",
"utcnow_ts": "1560715577914633"
}
}
[20:06:17.923] Task URL: https://ci.chromium.org/b/8910464819968679920
[20:06:17.923] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:2:0) after 1m0s
[20:06:24.072] Received PubSub notification, asking Buildbucket for the build status
[20:06:24.915] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:2:0)
[20:07:18.123] Timer tick, asking Buildbucket for the build status
[20:07:18.520] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:18.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:4:0) after 1m0s
[20:08:18.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:4:0)
[20:08:18.550] Timer tick, asking Buildbucket for the build status
[20:08:18.727] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:18.727] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:5:0) after 1m0s
[20:09:18.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:5:0)
[20:09:18.752] Timer tick, asking Buildbucket for the build status
[20:09:18.878] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:18.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:6:0) after 1m0s
[20:10:18.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:6:0)
[20:10:18.914] Timer tick, asking Buildbucket for the build status
[20:10:19.082] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:19.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:7:0) after 1m0s
[20:11:19.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:7:0)
[20:11:19.102] Timer tick, asking Buildbucket for the build status
[20:11:19.252] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:19.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:8:0) after 1m0s
[20:12:19.369] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:8:0)
[20:12:19.369] Timer tick, asking Buildbucket for the build status
[20:12:19.799] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:19.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:9:0) after 1m0s
[20:13:24.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:9:0)
[20:13:24.888] Timer tick, asking Buildbucket for the build status
[20:13:25.768] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:25.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:10:0) after 1m0s
[20:14:25.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:10:0)
[20:14:25.929] Timer tick, asking Buildbucket for the build status
[20:14:26.104] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:26.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:11:0) after 1m0s
[20:15:26.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:11:0)
[20:15:26.122] Timer tick, asking Buildbucket for the build status
[20:15:26.491] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:26.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:12:0) after 1m0s
[20:16:26.515] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:12:0)
[20:16:26.515] Timer tick, asking Buildbucket for the build status
[20:16:26.919] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:26.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:13:0) after 1m0s
[20:17:26.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:13:0)
[20:17:26.940] Timer tick, asking Buildbucket for the build status
[20:17:27.222] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:27.222] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:14:0) after 1m0s
[20:18:27.242] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:14:0)
[20:18:27.242] Timer tick, asking Buildbucket for the build status
[20:18:33.415] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:33.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:15:0) after 1m0s
[20:19:33.434] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:15:0)
[20:19:33.434] Timer tick, asking Buildbucket for the build status
[20:19:33.598] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:33.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:16:0) after 1m0s
[20:20:33.618] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:16:0)
[20:20:33.618] Timer tick, asking Buildbucket for the build status
[20:20:34.192] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:34.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:17:0) after 1m0s
[20:21:34.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:17:0)
[20:21:34.215] Timer tick, asking Buildbucket for the build status
[20:21:34.807] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:34.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:18:0) after 1m0s
[20:22:34.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:18:0)
[20:22:34.838] Timer tick, asking Buildbucket for the build status
[20:22:35.204] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:35.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:19:0) after 1m0s
[20:23:35.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:19:0)
[20:23:35.232] Timer tick, asking Buildbucket for the build status
[20:23:36.018] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:36.018] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:20:0) after 1m0s
[20:24:36.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:20:0)
[20:24:36.104] Timer tick, asking Buildbucket for the build status
[20:24:36.457] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:36.457] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:21:0) after 1m0s
[20:25:36.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:21:0)
[20:25:36.569] Timer tick, asking Buildbucket for the build status
[20:25:36.990] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:36.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:22:0) after 1m0s
[20:26:36.991] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:22:0)
[20:26:36.991] Timer tick, asking Buildbucket for the build status
[20:26:38.164] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:38.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:23:0) after 1m0s
[20:27:38.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:23:0)
[20:27:38.186] Timer tick, asking Buildbucket for the build status
[20:27:38.710] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:38.710] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:24:0) after 1m0s
[20:28:38.812] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:24:0)
[20:28:38.812] Timer tick, asking Buildbucket for the build status
[20:28:38.916] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:38.916] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:25:0) after 1m0s
[20:29:39.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:25:0)
[20:29:39.043] Timer tick, asking Buildbucket for the build status
[20:29:39.803] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:39.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:26:0) after 1m0s
[20:30:40.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:26:0)
[20:30:40.073] Timer tick, asking Buildbucket for the build status
[20:30:40.262] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:40.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:27:0) after 1m0s
[20:31:40.322] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:27:0)
[20:31:40.322] Timer tick, asking Buildbucket for the build status
[20:31:40.461] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:40.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:28:0) after 1m0s
[20:32:40.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:28:0)
[20:32:40.936] Timer tick, asking Buildbucket for the build status
[20:32:41.221] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:29:0) after 1m0s
[20:33:41.339] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:29:0)
[20:33:41.339] Timer tick, asking Buildbucket for the build status
[20:33:42.212] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:42.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:30:0) after 1m0s
[20:34:42.341] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:30:0)
[20:34:42.341] Timer tick, asking Buildbucket for the build status
[20:34:43.347] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:43.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:31:0) after 1m0s
[20:35:43.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:31:0)
[20:35:43.480] Timer tick, asking Buildbucket for the build status
[20:35:44.080] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:44.080] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:32:0) after 1m0s
[20:36:44.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:32:0)
[20:36:44.139] Timer tick, asking Buildbucket for the build status
[20:36:44.422] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:44.422] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:33:0) after 1m0s
[20:37:44.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:33:0)
[20:37:44.577] Timer tick, asking Buildbucket for the build status
[20:37:45.308] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:45.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:34:0) after 1m0s
[20:38:45.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:34:0)
[20:38:45.521] Timer tick, asking Buildbucket for the build status
[20:38:46.198] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:46.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:35:0) after 1m0s
[20:39:46.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:35:0)
[20:39:46.252] Timer tick, asking Buildbucket for the build status
[20:39:47.141] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:47.141] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:36:0) after 1m0s
[20:40:47.283] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:36:0)
[20:40:47.283] Timer tick, asking Buildbucket for the build status
[20:40:48.227] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:48.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:37:0) after 1m0s
[20:41:48.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:37:0)
[20:41:48.278] Timer tick, asking Buildbucket for the build status
[20:41:48.443] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:48.443] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:38:0) after 1m0s
[20:42:48.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:38:0)
[20:42:48.682] Timer tick, asking Buildbucket for the build status
[20:42:48.838] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:48.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:39:0) after 1m0s
[20:43:48.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:39:0)
[20:43:48.861] Timer tick, asking Buildbucket for the build status
[20:43:52.689] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:52.689] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:40:0) after 1m0s
[20:44:52.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:40:0)
[20:44:52.845] Timer tick, asking Buildbucket for the build status
[20:44:55.053] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:55.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:41:0) after 1m0s
[20:45:55.159] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:41:0)
[20:45:55.159] Timer tick, asking Buildbucket for the build status
[20:45:55.890] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:55.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:42:0) after 1m0s
[20:46:56.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:42:0)
[20:46:56.089] Timer tick, asking Buildbucket for the build status
[20:46:56.592] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:56.592] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:43:0) after 1m0s
[20:47:56.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:43:0)
[20:47:56.660] Timer tick, asking Buildbucket for the build status
[20:47:57.063] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:57.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:44:0) after 1m0s
[20:48:57.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:44:0)
[20:48:57.173] Timer tick, asking Buildbucket for the build status
[20:48:57.293] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:57.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:45:0) after 1m0s
[20:49:57.588] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:45:0)
[20:49:57.588] Timer tick, asking Buildbucket for the build status
[20:49:57.855] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:57.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:46:0) after 1m0s
[20:50:57.875] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:46:0)
[20:50:57.875] Timer tick, asking Buildbucket for the build status
[20:50:57.998] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:47:0) after 1m0s
[20:51:58.160] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:47:0)
[20:51:58.160] Timer tick, asking Buildbucket for the build status
[20:51:58.301] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:58.301] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:48:0) after 1m0s
[20:52:58.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:48:0)
[20:52:58.324] Timer tick, asking Buildbucket for the build status
[20:52:58.526] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:58.526] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:49:0) after 1m0s
[20:53:58.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:49:0)
[20:53:58.629] Timer tick, asking Buildbucket for the build status
[20:53:59.001] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:59.001] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:50:0) after 1m0s
[20:54:58.993] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:50:0)
[20:54:58.993] Timer tick, asking Buildbucket for the build status
[20:54:59.802] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:59.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:51:0) after 1m0s
[20:55:59.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:51:0)
[20:55:59.922] Timer tick, asking Buildbucket for the build status
[20:56:00.065] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:00.065] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:52:0) after 1m0s
[20:57:00.115] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:52:0)
[20:57:00.115] Timer tick, asking Buildbucket for the build status
[20:57:00.481] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:00.481] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:53:0) after 1m0s
[20:58:00.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:53:0)
[20:58:00.503] Timer tick, asking Buildbucket for the build status
[20:58:00.626] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:00.627] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:54:0) after 1m0s
[20:59:00.643] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:54:0)
[20:59:00.643] Timer tick, asking Buildbucket for the build status
[20:59:02.733] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:02.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:55:0) after 1m0s
[21:00:02.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:55:0)
[21:00:02.756] Timer tick, asking Buildbucket for the build status
[21:00:03.198] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:03.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:56:0) after 1m0s
[21:01:03.336] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:56:0)
[21:01:03.336] Timer tick, asking Buildbucket for the build status
[21:01:06.042] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:06.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:57:0) after 1m0s
[21:02:06.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:57:0)
[21:02:06.162] Timer tick, asking Buildbucket for the build status
[21:02:06.377] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:06.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:58:0) after 1m0s
[21:03:06.450] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:58:0)
[21:03:06.450] Timer tick, asking Buildbucket for the build status
[21:03:06.623] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:06.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:59:0) after 1m0s
[21:04:06.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:59:0)
[21:04:06.719] Timer tick, asking Buildbucket for the build status
[21:04:06.876] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:06.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:60:0) after 1m0s
[21:05:07.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:60:0)
[21:05:07.051] Timer tick, asking Buildbucket for the build status
[21:05:07.239] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:07.239] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:61:0) after 1m0s
[21:06:07.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:61:0)
[21:06:07.444] Timer tick, asking Buildbucket for the build status
[21:06:08.236] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:08.236] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:62:0) after 1m0s
[21:07:08.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:62:0)
[21:07:08.256] Timer tick, asking Buildbucket for the build status
[21:07:08.545] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:08.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:63:0) after 1m0s
[21:08:08.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:63:0)
[21:08:08.603] Timer tick, asking Buildbucket for the build status
[21:08:10.024] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:10.024] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:64:0) after 1m0s
[21:09:10.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:64:0)
[21:09:10.051] Timer tick, asking Buildbucket for the build status
[21:09:10.196] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:10.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:65:0) after 1m0s
[21:10:10.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:65:0)
[21:10:10.218] Timer tick, asking Buildbucket for the build status
[21:10:10.437] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:10.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:66:0) after 1m0s
[21:11:10.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:66:0)
[21:11:10.512] Timer tick, asking Buildbucket for the build status
[21:11:32.432] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:32.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:67:0) after 1m0s
[21:12:32.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:67:0)
[21:12:32.421] Timer tick, asking Buildbucket for the build status
[21:12:32.914] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:32.914] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:68:0) after 1m0s
[21:13:32.934] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:68:0)
[21:13:32.934] Timer tick, asking Buildbucket for the build status
[21:13:33.074] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:33.074] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:69:0) after 1m0s
[21:14:33.096] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:69:0)
[21:14:33.096] Timer tick, asking Buildbucket for the build status
[21:14:33.276] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:33.276] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:70:0) after 1m0s
[21:15:33.302] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:70:0)
[21:15:33.302] Timer tick, asking Buildbucket for the build status
[21:15:33.645] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:33.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:71:0) after 1m0s
[21:16:38.590] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:71:0)
[21:16:38.590] Timer tick, asking Buildbucket for the build status
[21:16:39.171] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:72:0) after 1m0s
[21:17:40.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:72:0)
[21:17:40.052] Timer tick, asking Buildbucket for the build status
[21:17:40.213] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.213] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:73:0) after 1m0s
[21:18:40.896] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:73:0)
[21:18:40.896] Timer tick, asking Buildbucket for the build status
[21:18:41.221] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:74:0) after 1m0s
[21:19:41.401] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:74:0)
[21:19:41.401] Timer tick, asking Buildbucket for the build status
[21:19:42.352] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:42.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:75:0) after 1m0s
[21:20:42.678] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:75:0)
[21:20:42.678] Timer tick, asking Buildbucket for the build status
[21:20:43.052] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:43.052] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:76:0) after 1m0s
[21:21:43.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:76:0)
[21:21:43.073] Timer tick, asking Buildbucket for the build status
[21:21:43.256] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:43.256] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:77:0) after 1m0s
[21:22:43.436] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:77:0)
[21:22:43.436] Timer tick, asking Buildbucket for the build status
[21:22:43.640] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.640] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:78:0) after 1m0s
[21:23:43.902] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:78:0)
[21:23:43.902] Timer tick, asking Buildbucket for the build status
[21:23:44.112] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:44.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:79:0) after 1m0s
[21:24:44.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:79:0)
[21:24:44.137] Timer tick, asking Buildbucket for the build status
[21:24:44.987] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:44.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:80:0) after 1m0s
[21:25:45.097] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:80:0)
[21:25:45.097] Timer tick, asking Buildbucket for the build status
[21:25:45.389] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:45.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:81:0) after 1m0s
[21:26:45.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:81:0)
[21:26:45.412] Timer tick, asking Buildbucket for the build status
[21:26:45.852] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:45.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:82:0) after 1m0s
[21:27:45.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:82:0)
[21:27:45.866] Timer tick, asking Buildbucket for the build status
[21:27:46.051] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:46.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:83:0) after 1m0s
[21:28:46.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:83:0)
[21:28:46.076] Timer tick, asking Buildbucket for the build status
[21:28:46.265] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:46.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:84:0) after 1m0s
[21:29:46.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:84:0)
[21:29:46.284] Timer tick, asking Buildbucket for the build status
[21:29:46.402] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:46.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:85:0) after 1m0s
[21:30:46.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:85:0)
[21:30:46.430] Timer tick, asking Buildbucket for the build status
[21:30:46.619] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:46.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:86:0) after 1m0s
[21:31:46.870] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:86:0)
[21:31:46.870] Timer tick, asking Buildbucket for the build status
[21:31:48.392] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:48.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:87:0) after 1m0s
[21:32:48.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:87:0)
[21:32:48.786] Timer tick, asking Buildbucket for the build status
[21:32:49.391] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:49.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:88:0) after 1m0s
[21:33:49.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:88:0)
[21:33:49.411] Timer tick, asking Buildbucket for the build status
[21:33:49.933] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:49.933] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:89:0) after 1m0s
[21:34:50.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:89:0)
[21:34:50.073] Timer tick, asking Buildbucket for the build status
[21:34:50.223] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:50.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:90:0) after 1m0s
[21:35:50.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:90:0)
[21:35:50.441] Timer tick, asking Buildbucket for the build status
[21:35:50.613] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:50.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:91:0) after 1m0s
[21:36:50.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:91:0)
[21:36:50.679] Timer tick, asking Buildbucket for the build status
[21:36:51.419] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:51.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:92:0) after 1m0s
[21:37:51.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:92:0)
[21:37:51.522] Timer tick, asking Buildbucket for the build status
[21:37:51.740] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:51.740] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:93:0) after 1m0s
[21:38:51.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:93:0)
[21:38:51.814] Timer tick, asking Buildbucket for the build status
[21:38:52.042] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:52.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:94:0) after 1m0s
[21:39:52.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:94:0)
[21:39:52.076] Timer tick, asking Buildbucket for the build status
[21:39:52.322] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.322] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:95:0) after 1m0s
[21:40:52.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:95:0)
[21:40:52.316] Timer tick, asking Buildbucket for the build status
[21:40:52.941] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:52.941] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:96:0) after 1m0s
[21:41:52.990] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:96:0)
[21:41:52.990] Timer tick, asking Buildbucket for the build status
[21:41:53.715] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:53.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:97:0) after 1m0s
[21:42:53.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:97:0)
[21:42:53.796] Timer tick, asking Buildbucket for the build status
[21:42:54.129] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:54.129] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:98:0) after 1m0s
[21:43:54.271] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:98:0)
[21:43:54.271] Timer tick, asking Buildbucket for the build status
[21:43:54.451] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:54.451] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:99:0) after 1m0s
[21:44:54.509] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:99:0)
[21:44:54.509] Timer tick, asking Buildbucket for the build status
[21:44:54.632] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:54.632] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:100:0) after 1m0s
[21:45:54.968] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:100:0)
[21:45:54.968] Timer tick, asking Buildbucket for the build status
[21:45:55.319] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:55.319] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:101:0) after 1m0s
[21:46:55.439] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:101:0)
[21:46:55.439] Timer tick, asking Buildbucket for the build status
[21:46:55.573] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.573] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:102:0) after 1m0s
[21:47:56.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:102:0)
[21:47:56.343] Timer tick, asking Buildbucket for the build status
[21:47:56.490] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:56.490] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:103:0) after 1m0s
[21:48:56.872] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:103:0)
[21:48:56.872] Timer tick, asking Buildbucket for the build status
[21:48:57.711] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:57.711] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:104:0) after 1m0s
[21:49:57.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:104:0)
[21:49:57.904] Timer tick, asking Buildbucket for the build status
[21:49:58.042] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:58.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:105:0) after 1m0s
[21:50:58.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:105:0)
[21:50:58.172] Timer tick, asking Buildbucket for the build status
[21:50:58.898] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:58.898] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:106:0) after 1m0s
[21:51:58.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:106:0)
[21:51:58.906] Timer tick, asking Buildbucket for the build status
[21:51:59.062] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:59.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:107:0) after 1m0s
[21:52:59.082] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:107:0)
[21:52:59.082] Timer tick, asking Buildbucket for the build status
[21:52:59.822] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:59.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:108:0) after 1m0s
[21:53:59.985] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:108:0)
[21:53:59.985] Timer tick, asking Buildbucket for the build status
[21:54:01.822] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:01.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:109:0) after 1m0s
[21:55:01.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:109:0)
[21:55:01.841] Timer tick, asking Buildbucket for the build status
[21:55:02.153] Build 8910464819968679920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:02.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9075894882352784096:110:0) after 1m0s
[21:55:43.544] Received PubSub notification, asking Buildbucket for the build status
[21:55:43.813] Build 8910464819968679920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:55:43.813] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1560722142881646",
"created_by": "project:chromium",
"created_ts": "1560715576162577",
"id": "8910464819968679920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"221c6f3dad0073f21079673f7b05a5ac88e13a95\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-trusty-8-22-97qg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23755, \"got_angle_revision\": \"95ac7b7ceeec16b77e06c85635906f70c38ced4d\", \"got_dawn_revision\": \"21eba761b5a0e99459b433210f1bdec82e052b92\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"221c6f3dad0073f21079673f7b05a5ac88e13a95\", \"got_revision_cp\": \"refs/heads/master@{#669546}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"b5e9cdd7b066c443c25672b545a5c547a0344545\", \"got_v8_revision_cp\": \"refs/heads/7.7.84@{#1}\", \"got_webrtc_revision\": \"e112bb84ef1fbf523f974a21a70ef0388b2070d2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28291}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"221c6f3dad0073f21079673f7b05a5ac88e13a95\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_662609c3a18ad850d61ba5f58749e60478bc4d9d576475e0c738a1c9e2d8d890_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_7e09b81c8d06479eaec2630704ae544ecbf4fef920ed2a3aec656c848d7a04d5_v2\", \"builder_a2d0deb167035deb42f2d46ec8df60bd17682f54960fd7d9f79bcb4fddee3411_v2\", \"builder_b9f10e617e36b89b59cf2468f05559e0083126a9b3741fee04e133349127cbf2_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-8-22-97qg\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4339-6285c57\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560715582175657",
"status": "COMPLETED",
"status_changed_ts": "1560722143146486",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23755",
"builder:Deterministic Linux",
"buildset:commit/git/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/221c6f3dad0073f21079673f7b05a5ac88e13a95",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9075894882352784096",
"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/8910464819968679920/+/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:457ab753f3bb6310",
"user_agent:luci-scheduler"
],
"updated_ts": "1560722143149531",
"url": "https://ci.chromium.org/b/8910464819968679920",
"utcnow_ts": "1560722143801804"
}
}
[21:55:43.813] Invocation finished in 1h49m29.307762784s with status SUCCEEDED