[06:57:42.791] New invocation is queued and will start shortly
[06:57:44.253] Starting the invocation (attempt 1)
[06:57:44.308] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:57:44.308] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:57:44.308] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9070418077349013344",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"467bd7b0a2a1f330b7e523564437f371a93e30ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9070418077349013344",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"gitiles_ref:refs/heads/master"
]
}
[06:57:45.182] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565938664561274",
"id": "8904988014827675936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"467bd7b0a2a1f330b7e523564437f371a93e30ff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565938665016829",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/10175",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070418077349013344",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8904988014827675936/+/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": "1565938665016988",
"url": "https://ci.chromium.org/b/8904988014827675936",
"utcnow_ts": "1565938665165688"
}
}
[06:57:45.182] Task URL: https://ci.chromium.org/b/8904988014827675936
[06:57:45.182] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:2:0) after 1m0s
[06:58:45.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:2:0)
[06:58:45.389] Timer tick, asking Buildbucket for the build status
[06:58:45.888] Build 8904988014827675936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:58:45.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:3:0) after 1m0s
[06:59:46.085] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:3:0)
[06:59:46.085] Timer tick, asking Buildbucket for the build status
[06:59:46.483] Build 8904988014827675936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:59:46.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:4:0) after 1m0s
[07:00:46.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:4:0)
[07:00:46.761] Timer tick, asking Buildbucket for the build status
[07:00:47.919] Build 8904988014827675936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:00:47.919] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:5:0) after 1m0s
[07:01:48.626] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:5:0)
[07:01:48.626] Timer tick, asking Buildbucket for the build status
[07:01:48.791] Build 8904988014827675936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:01:48.791] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:6:0) after 1m0s
[07:02:49.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:6:0)
[07:02:49.028] Timer tick, asking Buildbucket for the build status
[07:02:49.713] Build 8904988014827675936: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:02:49.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:7:0) after 1m0s
[07:03:08.635] Received PubSub notification, asking Buildbucket for the build status
[07:03:08.764] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:49.831] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:7:0)
[07:03:49.831] Timer tick, asking Buildbucket for the build status
[07:03:49.963] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:49.963] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:9:0) after 1m0s
[07:04:50.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:9:0)
[07:04:50.040] Timer tick, asking Buildbucket for the build status
[07:04:50.263] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:50.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:10:0) after 1m0s
[07:05:50.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:10:0)
[07:05:50.358] Timer tick, asking Buildbucket for the build status
[07:05:50.629] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:50.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:11:0) after 1m0s
[07:06:50.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:11:0)
[07:06:50.692] Timer tick, asking Buildbucket for the build status
[07:06:51.287] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:51.287] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:12:0) after 1m0s
[07:07:51.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:12:0)
[07:07:51.311] Timer tick, asking Buildbucket for the build status
[07:07:51.699] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:51.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:13:0) after 1m0s
[07:08:51.810] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:13:0)
[07:08:51.810] Timer tick, asking Buildbucket for the build status
[07:08:51.980] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:51.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:14:0) after 1m0s
[07:09:52.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:14:0)
[07:09:52.028] Timer tick, asking Buildbucket for the build status
[07:09:52.555] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:52.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:15:0) after 1m0s
[07:10:52.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:15:0)
[07:10:52.608] Timer tick, asking Buildbucket for the build status
[07:10:52.847] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:52.847] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:16:0) after 1m0s
[07:11:52.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:16:0)
[07:11:52.904] Timer tick, asking Buildbucket for the build status
[07:11:53.495] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:53.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:17:0) after 1m0s
[07:12:53.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:17:0)
[07:12:53.716] Timer tick, asking Buildbucket for the build status
[07:12:54.181] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:54.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:18:0) after 1m0s
[07:13:54.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:18:0)
[07:13:54.535] Timer tick, asking Buildbucket for the build status
[07:13:54.864] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:19:0) after 1m0s
[07:14:54.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:19:0)
[07:14:54.967] Timer tick, asking Buildbucket for the build status
[07:14:55.556] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:55.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:20:0) after 1m0s
[07:15:55.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:20:0)
[07:15:55.629] Timer tick, asking Buildbucket for the build status
[07:15:55.819] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:55.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:21:0) after 1m0s
[07:16:56.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:21:0)
[07:16:56.185] Timer tick, asking Buildbucket for the build status
[07:16:56.373] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:56.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:22:0) after 1m0s
[07:17:56.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:22:0)
[07:17:56.577] Timer tick, asking Buildbucket for the build status
[07:17:58.066] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:58.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:23:0) after 1m0s
[07:18:58.732] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:23:0)
[07:18:58.732] Timer tick, asking Buildbucket for the build status
[07:18:58.897] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:58.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:24:0) after 1m0s
[07:19:58.977] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:24:0)
[07:19:58.977] Timer tick, asking Buildbucket for the build status
[07:19:59.438] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:59.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:25:0) after 1m0s
[07:20:59.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:25:0)
[07:20:59.702] Timer tick, asking Buildbucket for the build status
[07:21:01.525] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:01.525] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:26:0) after 1m0s
[07:22:01.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:26:0)
[07:22:01.762] Timer tick, asking Buildbucket for the build status
[07:22:01.953] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:01.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:27:0) after 1m0s
[07:23:02.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:27:0)
[07:23:02.191] Timer tick, asking Buildbucket for the build status
[07:23:02.341] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:02.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:28:0) after 1m0s
[07:24:02.428] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:28:0)
[07:24:02.428] Timer tick, asking Buildbucket for the build status
[07:24:02.590] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:02.590] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:29:0) after 1m0s
[07:25:02.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:29:0)
[07:25:02.811] Timer tick, asking Buildbucket for the build status
[07:25:03.063] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:03.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:30:0) after 1m0s
[07:26:03.193] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:30:0)
[07:26:03.193] Timer tick, asking Buildbucket for the build status
[07:26:04.097] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:04.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:31:0) after 1m0s
[07:27:04.197] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:31:0)
[07:27:04.197] Timer tick, asking Buildbucket for the build status
[07:27:04.751] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:04.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:32:0) after 1m0s
[07:28:05.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:32:0)
[07:28:05.046] Timer tick, asking Buildbucket for the build status
[07:28:05.201] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:05.201] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:33:0) after 1m0s
[07:29:05.207] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:33:0)
[07:29:05.207] Timer tick, asking Buildbucket for the build status
[07:29:05.483] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:05.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:34:0) after 1m0s
[07:30:05.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:34:0)
[07:30:05.486] Timer tick, asking Buildbucket for the build status
[07:30:06.179] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:06.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:35:0) after 1m0s
[07:31:06.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:35:0)
[07:31:06.274] Timer tick, asking Buildbucket for the build status
[07:31:07.838] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:07.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:36:0) after 1m0s
[07:32:07.854] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:36:0)
[07:32:07.854] Timer tick, asking Buildbucket for the build status
[07:32:08.145] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:08.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:37:0) after 1m0s
[07:33:08.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:37:0)
[07:33:08.327] Timer tick, asking Buildbucket for the build status
[07:33:08.516] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:08.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:38:0) after 1m0s
[07:34:08.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:38:0)
[07:34:08.645] Timer tick, asking Buildbucket for the build status
[07:34:09.000] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:09.000] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:39:0) after 1m0s
[07:35:09.065] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:39:0)
[07:35:09.065] Timer tick, asking Buildbucket for the build status
[07:35:09.688] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:09.688] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:40:0) after 1m0s
[07:36:09.776] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:40:0)
[07:36:09.776] Timer tick, asking Buildbucket for the build status
[07:36:10.034] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:10.034] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:41:0) after 1m0s
[07:37:10.073] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:41:0)
[07:37:10.073] Timer tick, asking Buildbucket for the build status
[07:37:10.258] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:10.258] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:42:0) after 1m0s
[07:38:10.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:42:0)
[07:38:10.311] Timer tick, asking Buildbucket for the build status
[07:38:10.752] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:10.752] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:43:0) after 1m0s
[07:39:10.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:43:0)
[07:39:10.813] Timer tick, asking Buildbucket for the build status
[07:39:10.945] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:10.945] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:44:0) after 1m0s
[07:40:10.967] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:44:0)
[07:40:10.967] Timer tick, asking Buildbucket for the build status
[07:40:11.619] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:11.619] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:45:0) after 1m0s
[07:41:11.799] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:45:0)
[07:41:11.799] Timer tick, asking Buildbucket for the build status
[07:41:11.974] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:11.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:46:0) after 1m0s
[07:42:12.102] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:46:0)
[07:42:12.102] Timer tick, asking Buildbucket for the build status
[07:42:12.354] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:12.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:47:0) after 1m0s
[07:43:12.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:47:0)
[07:43:12.412] Timer tick, asking Buildbucket for the build status
[07:43:12.896] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:12.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:48:0) after 1m0s
[07:44:13.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:48:0)
[07:44:13.004] Timer tick, asking Buildbucket for the build status
[07:44:13.536] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:13.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:49:0) after 1m0s
[07:45:13.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:49:0)
[07:45:13.617] Timer tick, asking Buildbucket for the build status
[07:45:14.278] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:14.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:50:0) after 1m0s
[07:46:14.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:50:0)
[07:46:14.543] Timer tick, asking Buildbucket for the build status
[07:46:14.746] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:14.746] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:51:0) after 1m0s
[07:47:14.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:51:0)
[07:47:14.825] Timer tick, asking Buildbucket for the build status
[07:47:15.006] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:15.006] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:52:0) after 1m0s
[07:48:15.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:52:0)
[07:48:15.001] Timer tick, asking Buildbucket for the build status
[07:48:15.215] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:15.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:53:0) after 1m0s
[07:49:15.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:53:0)
[07:49:15.237] Timer tick, asking Buildbucket for the build status
[07:49:15.493] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:15.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:54:0) after 1m0s
[07:50:15.578] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:54:0)
[07:50:15.578] Timer tick, asking Buildbucket for the build status
[07:50:16.325] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:16.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:55:0) after 1m0s
[07:51:16.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:55:0)
[07:51:16.398] Timer tick, asking Buildbucket for the build status
[07:51:16.649] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:16.649] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:56:0) after 1m0s
[07:52:16.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:56:0)
[07:52:16.711] Timer tick, asking Buildbucket for the build status
[07:52:16.894] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:16.894] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:57:0) after 1m0s
[07:53:17.057] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:57:0)
[07:53:17.057] Timer tick, asking Buildbucket for the build status
[07:53:17.212] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:17.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:58:0) after 1m0s
[07:54:17.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:58:0)
[07:54:17.285] Timer tick, asking Buildbucket for the build status
[07:54:17.450] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:17.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:59:0) after 1m0s
[07:55:18.317] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:59:0)
[07:55:18.317] Timer tick, asking Buildbucket for the build status
[07:55:19.379] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:19.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:60:0) after 1m0s
[07:56:19.411] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:60:0)
[07:56:19.411] Timer tick, asking Buildbucket for the build status
[07:56:19.782] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:19.782] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:61:0) after 1m0s
[07:57:19.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:61:0)
[07:57:19.925] Timer tick, asking Buildbucket for the build status
[07:57:20.603] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:20.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:62:0) after 1m0s
[07:58:20.634] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:62:0)
[07:58:20.634] Timer tick, asking Buildbucket for the build status
[07:58:21.211] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:21.211] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:63:0) after 1m0s
[07:59:21.267] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:63:0)
[07:59:21.267] Timer tick, asking Buildbucket for the build status
[07:59:21.648] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:21.648] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:64:0) after 1m0s
[08:00:21.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:64:0)
[08:00:21.642] Timer tick, asking Buildbucket for the build status
[08:00:21.799] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:21.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:65:0) after 1m0s
[08:01:22.062] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:65:0)
[08:01:22.062] Timer tick, asking Buildbucket for the build status
[08:01:22.400] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:22.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:66:0) after 1m0s
[08:02:22.441] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:66:0)
[08:02:22.441] Timer tick, asking Buildbucket for the build status
[08:02:22.628] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:22.628] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:67:0) after 1m0s
[08:03:22.701] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:67:0)
[08:03:22.701] Timer tick, asking Buildbucket for the build status
[08:03:23.826] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:23.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:68:0) after 1m0s
[08:04:23.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:68:0)
[08:04:23.911] Timer tick, asking Buildbucket for the build status
[08:04:24.171] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:24.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:69:0) after 1m0s
[08:05:24.216] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:69:0)
[08:05:24.216] Timer tick, asking Buildbucket for the build status
[08:05:24.391] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:24.391] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:70:0) after 1m0s
[08:06:24.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:70:0)
[08:06:24.414] Timer tick, asking Buildbucket for the build status
[08:06:24.732] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:24.733] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:71:0) after 1m0s
[08:07:24.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:71:0)
[08:07:24.889] Timer tick, asking Buildbucket for the build status
[08:07:25.178] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:25.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:72:0) after 1m0s
[08:08:25.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:72:0)
[08:08:25.218] Timer tick, asking Buildbucket for the build status
[08:08:25.911] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:25.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:73:0) after 1m0s
[08:09:25.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:73:0)
[08:09:25.964] Timer tick, asking Buildbucket for the build status
[08:09:27.188] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:27.188] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:74:0) after 1m0s
[08:10:27.204] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:74:0)
[08:10:27.204] Timer tick, asking Buildbucket for the build status
[08:10:27.551] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:27.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:75:0) after 1m0s
[08:11:27.587] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:75:0)
[08:11:27.587] Timer tick, asking Buildbucket for the build status
[08:11:28.064] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:28.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:76:0) after 1m0s
[08:12:28.285] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:76:0)
[08:12:28.285] Timer tick, asking Buildbucket for the build status
[08:12:28.579] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:28.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:77:0) after 1m0s
[08:13:28.630] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:77:0)
[08:13:28.630] Timer tick, asking Buildbucket for the build status
[08:13:29.363] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:29.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:78:0) after 1m0s
[08:14:29.416] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:78:0)
[08:14:29.416] Timer tick, asking Buildbucket for the build status
[08:14:30.035] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:30.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:79:0) after 1m0s
[08:15:30.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:79:0)
[08:15:30.187] Timer tick, asking Buildbucket for the build status
[08:15:30.499] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:30.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:80:0) after 1m0s
[08:16:30.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:80:0)
[08:16:30.543] Timer tick, asking Buildbucket for the build status
[08:16:30.700] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:30.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:81:0) after 1m0s
[08:17:30.752] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:81:0)
[08:17:30.752] Timer tick, asking Buildbucket for the build status
[08:17:30.951] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:30.951] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:82:0) after 1m0s
[08:18:30.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:82:0)
[08:18:30.999] Timer tick, asking Buildbucket for the build status
[08:18:31.247] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:31.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:83:0) after 1m0s
[08:19:31.345] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:83:0)
[08:19:31.345] Timer tick, asking Buildbucket for the build status
[08:19:31.844] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:31.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:84:0) after 1m0s
[08:20:31.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:84:0)
[08:20:31.957] Timer tick, asking Buildbucket for the build status
[08:20:32.214] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:32.214] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:85:0) after 1m0s
[08:21:32.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:85:0)
[08:21:32.237] Timer tick, asking Buildbucket for the build status
[08:21:32.693] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:32.694] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:86:0) after 1m0s
[08:22:32.782] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:86:0)
[08:22:32.782] Timer tick, asking Buildbucket for the build status
[08:22:32.943] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:32.943] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:87:0) after 1m0s
[08:23:33.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:87:0)
[08:23:33.009] Timer tick, asking Buildbucket for the build status
[08:23:33.191] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:33.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:88:0) after 1m0s
[08:24:33.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:88:0)
[08:24:33.218] Timer tick, asking Buildbucket for the build status
[08:24:34.394] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:34.394] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:89:0) after 1m0s
[08:25:34.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:89:0)
[08:25:34.468] Timer tick, asking Buildbucket for the build status
[08:25:34.672] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:34.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:90:0) after 1m0s
[08:26:34.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:90:0)
[08:26:34.761] Timer tick, asking Buildbucket for the build status
[08:26:35.460] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:35.460] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:91:0) after 1m0s
[08:27:35.483] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:91:0)
[08:27:35.483] Timer tick, asking Buildbucket for the build status
[08:27:35.751] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:35.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:92:0) after 1m0s
[08:28:35.820] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:92:0)
[08:28:35.820] Timer tick, asking Buildbucket for the build status
[08:28:36.148] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:36.148] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:93:0) after 1m0s
[08:29:36.136] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:93:0)
[08:29:36.136] Timer tick, asking Buildbucket for the build status
[08:29:36.312] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.312] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:94:0) after 1m0s
[08:30:36.368] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:94:0)
[08:30:36.368] Timer tick, asking Buildbucket for the build status
[08:30:37.807] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:37.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:95:0) after 1m0s
[08:31:37.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:95:0)
[08:31:37.985] Timer tick, asking Buildbucket for the build status
[08:31:38.273] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:38.273] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:96:0) after 1m0s
[08:32:38.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:96:0)
[08:32:38.531] Timer tick, asking Buildbucket for the build status
[08:32:39.342] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:39.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:97:0) after 1m0s
[08:33:39.354] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:97:0)
[08:33:39.354] Timer tick, asking Buildbucket for the build status
[08:33:40.163] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:40.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:98:0) after 1m0s
[08:34:40.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:98:0)
[08:34:40.291] Timer tick, asking Buildbucket for the build status
[08:34:40.990] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:40.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:99:0) after 1m0s
[08:35:40.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:99:0)
[08:35:40.984] Timer tick, asking Buildbucket for the build status
[08:35:41.317] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:41.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:100:0) after 1m0s
[08:36:41.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:100:0)
[08:36:41.500] Timer tick, asking Buildbucket for the build status
[08:36:42.082] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:42.082] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:101:0) after 1m0s
[08:37:42.246] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:101:0)
[08:37:42.246] Timer tick, asking Buildbucket for the build status
[08:37:42.437] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:42.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:102:0) after 1m0s
[08:38:42.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:102:0)
[08:38:42.577] Timer tick, asking Buildbucket for the build status
[08:38:43.062] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:43.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:103:0) after 1m0s
[08:39:43.577] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:103:0)
[08:39:43.577] Timer tick, asking Buildbucket for the build status
[08:39:44.636] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:104:0) after 1m0s
[08:40:45.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:104:0)
[08:40:45.086] Timer tick, asking Buildbucket for the build status
[08:40:45.367] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:45.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:105:0) after 1m0s
[08:41:45.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:105:0)
[08:41:45.508] Timer tick, asking Buildbucket for the build status
[08:41:46.077] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:46.077] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:106:0) after 1m0s
[08:42:46.234] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:106:0)
[08:42:46.234] Timer tick, asking Buildbucket for the build status
[08:42:46.606] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:46.606] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:107:0) after 1m0s
[08:43:46.761] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:107:0)
[08:43:46.761] Timer tick, asking Buildbucket for the build status
[08:43:47.808] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:47.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:108:0) after 1m0s
[08:44:48.118] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:108:0)
[08:44:48.118] Timer tick, asking Buildbucket for the build status
[08:44:49.212] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:49.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:109:0) after 1m0s
[08:45:49.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:109:0)
[08:45:49.351] Timer tick, asking Buildbucket for the build status
[08:45:49.522] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:49.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:110:0) after 1m0s
[08:46:49.691] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:110:0)
[08:46:49.691] Timer tick, asking Buildbucket for the build status
[08:46:50.849] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:50.849] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:111:0) after 1m0s
[08:47:51.516] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:111:0)
[08:47:51.516] Timer tick, asking Buildbucket for the build status
[08:47:51.850] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:51.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:112:0) after 1m0s
[08:48:51.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:112:0)
[08:48:51.922] Timer tick, asking Buildbucket for the build status
[08:48:52.347] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:52.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:113:0) after 1m0s
[08:49:52.330] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:113:0)
[08:49:52.330] Timer tick, asking Buildbucket for the build status
[08:49:53.224] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:53.224] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:114:0) after 1m0s
[08:50:53.335] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:114:0)
[08:50:53.335] Timer tick, asking Buildbucket for the build status
[08:50:53.478] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:53.478] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:115:0) after 1m0s
[08:51:53.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:115:0)
[08:51:53.532] Timer tick, asking Buildbucket for the build status
[08:51:54.106] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:54.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:116:0) after 1m0s
[08:52:54.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:116:0)
[08:52:54.195] Timer tick, asking Buildbucket for the build status
[08:52:54.950] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:54.950] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:117:0) after 1m0s
[08:53:55.028] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:117:0)
[08:53:55.028] Timer tick, asking Buildbucket for the build status
[08:53:55.230] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:55.230] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:118:0) after 1m0s
[08:54:55.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:118:0)
[08:54:55.256] Timer tick, asking Buildbucket for the build status
[08:54:55.412] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:55.412] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:119:0) after 1m0s
[08:55:55.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:119:0)
[08:55:55.480] Timer tick, asking Buildbucket for the build status
[08:55:55.633] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:55.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:120:0) after 1m0s
[08:56:55.692] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:120:0)
[08:56:55.692] Timer tick, asking Buildbucket for the build status
[08:56:56.456] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:56.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:121:0) after 1m0s
[08:57:56.484] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:121:0)
[08:57:56.484] Timer tick, asking Buildbucket for the build status
[08:57:56.936] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:56.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:122:0) after 1m0s
[08:58:56.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:122:0)
[08:58:56.954] Timer tick, asking Buildbucket for the build status
[08:58:57.646] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:57.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:123:0) after 1m0s
[08:59:57.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:123:0)
[08:59:57.724] Timer tick, asking Buildbucket for the build status
[08:59:57.866] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:57.866] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:124:0) after 1m0s
[09:00:57.894] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:124:0)
[09:00:57.894] Timer tick, asking Buildbucket for the build status
[09:00:58.029] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:58.029] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:125:0) after 1m0s
[09:01:58.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:125:0)
[09:01:58.108] Timer tick, asking Buildbucket for the build status
[09:01:58.415] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:58.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:126:0) after 1m0s
[09:02:58.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:126:0)
[09:02:58.537] Timer tick, asking Buildbucket for the build status
[09:02:58.687] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:58.687] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:127:0) after 1m0s
[09:03:58.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:127:0)
[09:03:58.762] Timer tick, asking Buildbucket for the build status
[09:03:59.509] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:59.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:128:0) after 1m0s
[09:04:59.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:128:0)
[09:04:59.547] Timer tick, asking Buildbucket for the build status
[09:05:00.263] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:00.263] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:129:0) after 1m0s
[09:06:00.353] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:129:0)
[09:06:00.353] Timer tick, asking Buildbucket for the build status
[09:06:02.693] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:02.693] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:130:0) after 1m0s
[09:07:02.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:130:0)
[09:07:02.802] Timer tick, asking Buildbucket for the build status
[09:07:02.990] Build 8904988014827675936: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:02.990] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9070418077349013344:131:0) after 1m0s
[09:07:38.196] Received PubSub notification, asking Buildbucket for the build status
[09:07:38.634] Build 8904988014827675936: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[09:07:38.634] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565946457093629",
"created_by": "project:chromium",
"created_ts": "1565938664561274",
"failure_reason": "BUILD_FAILURE",
"id": "8904988014827675936",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"467bd7b0a2a1f330b7e523564437f371a93e30ff\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _First build_ failed. Error logs are shown below:\\n```\\n[66244/72531] ACTION //services/network/public/mojom:websocket_mojom_js_library(//build/toolchain/linux:clang_x64)\\nFAILED: gen/services/network/public/mojom/websocket_mojom_js_library.js_library\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"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-xenial-32-18-u3i0\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 10175, \"got_angle_revision\": \"cdecd97ceefa28409793d04caf873e7b0d0d723c\", \"got_dawn_revision\": \"ae2415c6f5136fee61beeb48820fd45877bc8c86\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"467bd7b0a2a1f330b7e523564437f371a93e30ff\", \"got_revision_cp\": \"refs/heads/master@{#687583}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2e90534616abb543dabe25726e852b04baba0c7c\", \"got_v8_revision_cp\": \"refs/heads/7.8.111@{#2}\", \"got_webrtc_revision\": \"7c6f74ab0344e9c6201de711d54026e9990b8e6c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28844}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"467bd7b0a2a1f330b7e523564437f371a93e30ff\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0264569d20b29e1d5e6df044c8d1223ed84f9f22180c83dac41e8db0ff2b71db_v2\", \"builder_02c489102c6b23f720d825d3d639a9c0a891978418b04ce86081f51b1a63cfd3_v2\", \"builder_4071df92b94331eb3da38507368746e2a4f045780701cbd95f86ba21c63ad0a4_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_7fff4868edc30aeb70bca6692fd4de56946386446c5e4143b85cddc68507392e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-18-u3i0\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"#### Step _First build_ failed. Error logs are shown below:\\n```\\n[66244/72531] ACTION //services/network/public/mojom:websocket_mojom_js_library(//build/toolchain/linux:clang_x64)\\nFAILED: gen/services/network/public/mojom/websocket_mojom_js_library.js_library\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1565938986088969",
"status": "COMPLETED",
"status_changed_ts": "1565938987834774",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/10175",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/467bd7b0a2a1f330b7e523564437f371a93e30ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9070418077349013344",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8904988014827675936/+/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:46b209504e628210",
"user_agent:luci-scheduler"
],
"updated_ts": "1565946457480793",
"url": "https://ci.chromium.org/b/8904988014827675936",
"utcnow_ts": "1565946458620895"
}
}
[09:07:38.634] Invocation finished in 2h9m55.861142897s with status FAILED