[06:05:36.575] New invocation is queued and will start shortly
[06:05:37.815] Starting the invocation (attempt 1)
[06:05:37.875] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:05:37.875] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:05:37.875] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076491352172784496",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"fd3248750ececbce5df5d235aaac4477dae623d2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9076491352172784496",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/fd3248750ececbce5df5d235aaac4477dae623d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd3248750ececbce5df5d235aaac4477dae623d2",
"gitiles_ref:refs/heads/master"
]
}
[06:05:40.187] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1560146738142523",
"id": "8911061289864642960",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd3248750ececbce5df5d235aaac4477dae623d2\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1560146739352310",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23672",
"builder:Deterministic Linux",
"buildset:commit/git/fd3248750ececbce5df5d235aaac4477dae623d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd3248750ececbce5df5d235aaac4477dae623d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076491352172784496",
"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/8911061289864642960/+/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": "1560146739352416",
"url": "https://ci.chromium.org/b/8911061289864642960",
"utcnow_ts": "1560146740128639"
}
}
[06:05:40.187] Task URL: https://ci.chromium.org/b/8911061289864642960
[06:05:40.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:2:0) after 1m0s
[06:06:24.631] Received PubSub notification, asking Buildbucket for the build status
[06:06:24.830] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:40.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:2:0)
[06:06:40.220] Timer tick, asking Buildbucket for the build status
[06:06:40.516] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:40.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:4:0) after 1m0s
[06:07:40.585] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:4:0)
[06:07:40.585] Timer tick, asking Buildbucket for the build status
[06:07:40.956] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:40.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:5:0) after 1m0s
[06:08:41.013] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:5:0)
[06:08:41.013] Timer tick, asking Buildbucket for the build status
[06:08:41.425] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:41.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:6:0) after 1m0s
[06:09:41.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:6:0)
[06:09:41.584] Timer tick, asking Buildbucket for the build status
[06:09:42.876] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:42.876] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:7:0) after 1m0s
[06:10:42.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:7:0)
[06:10:42.954] Timer tick, asking Buildbucket for the build status
[06:10:44.765] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:44.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:8:0) after 1m0s
[06:11:44.786] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:8:0)
[06:11:44.786] Timer tick, asking Buildbucket for the build status
[06:11:45.261] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:45.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:9:0) after 1m0s
[06:12:45.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:9:0)
[06:12:45.328] Timer tick, asking Buildbucket for the build status
[06:12:45.456] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:45.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:10:0) after 1m0s
[06:13:45.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:10:0)
[06:13:45.504] Timer tick, asking Buildbucket for the build status
[06:13:45.672] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:11:0) after 1m0s
[06:14:45.845] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:11:0)
[06:14:45.845] Timer tick, asking Buildbucket for the build status
[06:14:45.923] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:45.924] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:12:0) after 1m0s
[06:15:45.943] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:12:0)
[06:15:45.943] Timer tick, asking Buildbucket for the build status
[06:15:46.058] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:46.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:13:0) after 1m0s
[06:16:46.126] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:13:0)
[06:16:46.126] Timer tick, asking Buildbucket for the build status
[06:16:46.840] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:46.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:14:0) after 1m0s
[06:17:46.833] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:14:0)
[06:17:46.833] Timer tick, asking Buildbucket for the build status
[06:17:48.131] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:48.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:15:0) after 1m0s
[06:18:48.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:15:0)
[06:18:48.199] Timer tick, asking Buildbucket for the build status
[06:18:48.355] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:48.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:16:0) after 1m0s
[06:19:48.430] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:16:0)
[06:19:48.430] Timer tick, asking Buildbucket for the build status
[06:19:49.704] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:49.704] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:17:0) after 1m0s
[06:20:49.830] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:17:0)
[06:20:49.830] Timer tick, asking Buildbucket for the build status
[06:20:49.999] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:49.999] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:18:0) after 1m0s
[06:21:50.024] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:18:0)
[06:21:50.024] Timer tick, asking Buildbucket for the build status
[06:21:51.380] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:51.380] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:19:0) after 1m0s
[06:22:51.415] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:19:0)
[06:22:51.415] Timer tick, asking Buildbucket for the build status
[06:22:51.540] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:51.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:20:0) after 1m0s
[06:23:51.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:20:0)
[06:23:51.617] Timer tick, asking Buildbucket for the build status
[06:23:52.295] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:52.295] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:21:0) after 1m0s
[06:24:52.311] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:21:0)
[06:24:52.311] Timer tick, asking Buildbucket for the build status
[06:24:52.513] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:52.513] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:22:0) after 1m0s
[06:25:52.530] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:22:0)
[06:25:52.530] Timer tick, asking Buildbucket for the build status
[06:25:53.121] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:53.121] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:23:0) after 1m0s
[06:26:53.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:23:0)
[06:26:53.284] Timer tick, asking Buildbucket for the build status
[06:26:53.453] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:53.453] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:24:0) after 1m0s
[06:27:53.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:24:0)
[06:27:53.573] Timer tick, asking Buildbucket for the build status
[06:27:54.450] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:54.450] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:25:0) after 1m0s
[06:28:54.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:25:0)
[06:28:54.508] Timer tick, asking Buildbucket for the build status
[06:28:55.588] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:55.588] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:26:0) after 1m0s
[06:29:55.610] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:26:0)
[06:29:55.610] Timer tick, asking Buildbucket for the build status
[06:29:55.738] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:55.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:27:0) after 1m0s
[06:30:55.805] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:27:0)
[06:30:55.805] Timer tick, asking Buildbucket for the build status
[06:30:55.956] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:55.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:28:0) after 1m0s
[06:31:56.002] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:28:0)
[06:31:56.002] Timer tick, asking Buildbucket for the build status
[06:31:56.281] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:56.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:29:0) after 1m0s
[06:32:56.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:29:0)
[06:32:56.350] Timer tick, asking Buildbucket for the build status
[06:32:56.445] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:56.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:30:0) after 1m0s
[06:33:56.470] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:30:0)
[06:33:56.470] Timer tick, asking Buildbucket for the build status
[06:33:58.173] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:58.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:31:0) after 1m0s
[06:34:58.185] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:31:0)
[06:34:58.185] Timer tick, asking Buildbucket for the build status
[06:34:59.956] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:59.956] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:32:0) after 1m0s
[06:35:59.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:32:0)
[06:35:59.976] Timer tick, asking Buildbucket for the build status
[06:36:00.649] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:00.649] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:33:0) after 1m0s
[06:37:00.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:33:0)
[06:37:00.720] Timer tick, asking Buildbucket for the build status
[06:37:01.475] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:01.475] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:34:0) after 1m0s
[06:38:01.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:34:0)
[06:38:01.503] Timer tick, asking Buildbucket for the build status
[06:38:01.663] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:01.663] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:35:0) after 1m0s
[06:39:01.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:35:0)
[06:39:01.689] Timer tick, asking Buildbucket for the build status
[06:39:01.971] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:01.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:36:0) after 1m0s
[06:40:02.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:36:0)
[06:40:02.035] Timer tick, asking Buildbucket for the build status
[06:40:02.194] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:02.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:37:0) after 1m0s
[06:41:02.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:37:0)
[06:41:02.269] Timer tick, asking Buildbucket for the build status
[06:41:02.753] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:02.753] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:38:0) after 1m0s
[06:42:02.863] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:38:0)
[06:42:02.863] Timer tick, asking Buildbucket for the build status
[06:42:03.470] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:03.470] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:39:0) after 1m0s
[06:43:03.533] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:39:0)
[06:43:03.533] Timer tick, asking Buildbucket for the build status
[06:43:04.327] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:04.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:40:0) after 1m0s
[06:44:04.447] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:40:0)
[06:44:04.447] Timer tick, asking Buildbucket for the build status
[06:44:05.005] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:05.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:41:0) after 1m0s
[06:45:05.252] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:41:0)
[06:45:05.252] Timer tick, asking Buildbucket for the build status
[06:45:05.362] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:05.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:42:0) after 1m0s
[06:46:06.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:42:0)
[06:46:06.276] Timer tick, asking Buildbucket for the build status
[06:46:07.556] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:07.556] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:43:0) after 1m0s
[06:47:07.591] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:43:0)
[06:47:07.591] Timer tick, asking Buildbucket for the build status
[06:47:07.720] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:44:0) after 1m0s
[06:48:07.765] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:44:0)
[06:48:07.765] Timer tick, asking Buildbucket for the build status
[06:48:07.893] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:07.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:45:0) after 1m0s
[06:49:07.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:45:0)
[06:49:07.984] Timer tick, asking Buildbucket for the build status
[06:49:09.337] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:09.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:46:0) after 1m0s
[06:50:09.358] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:46:0)
[06:50:09.358] Timer tick, asking Buildbucket for the build status
[06:50:10.173] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:10.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:47:0) after 1m0s
[06:51:10.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:47:0)
[06:51:10.256] Timer tick, asking Buildbucket for the build status
[06:51:12.063] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:12.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:48:0) after 1m0s
[06:52:12.092] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:48:0)
[06:52:12.092] Timer tick, asking Buildbucket for the build status
[06:52:12.196] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:12.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:49:0) after 1m0s
[06:53:12.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:49:0)
[06:53:12.284] Timer tick, asking Buildbucket for the build status
[06:53:12.793] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:12.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:50:0) after 1m0s
[06:54:12.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:50:0)
[06:54:12.814] Timer tick, asking Buildbucket for the build status
[06:54:13.240] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:13.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:51:0) after 1m0s
[06:55:13.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:51:0)
[06:55:13.905] Timer tick, asking Buildbucket for the build status
[06:55:14.013] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:14.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:52:0) after 1m0s
[06:56:14.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:52:0)
[06:56:14.034] Timer tick, asking Buildbucket for the build status
[06:56:15.329] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:15.329] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:53:0) after 1m0s
[06:57:15.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:53:0)
[06:57:15.492] Timer tick, asking Buildbucket for the build status
[06:57:15.593] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:15.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:54:0) after 1m0s
[06:58:15.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:54:0)
[06:58:15.779] Timer tick, asking Buildbucket for the build status
[06:58:15.887] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:15.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:55:0) after 1m0s
[06:59:15.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:55:0)
[06:59:15.946] Timer tick, asking Buildbucket for the build status
[06:59:16.063] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:16.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:56:0) after 1m0s
[07:00:16.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:56:0)
[07:00:16.084] Timer tick, asking Buildbucket for the build status
[07:00:17.196] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:17.196] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:57:0) after 1m0s
[07:01:17.408] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:57:0)
[07:01:17.408] Timer tick, asking Buildbucket for the build status
[07:01:17.587] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:17.587] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:58:0) after 1m0s
[07:02:17.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:58:0)
[07:02:17.666] Timer tick, asking Buildbucket for the build status
[07:02:18.980] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:18.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:59:0) after 1m0s
[07:03:19.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:59:0)
[07:03:19.202] Timer tick, asking Buildbucket for the build status
[07:03:20.841] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:20.841] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:60:0) after 1m0s
[07:04:20.931] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:60:0)
[07:04:20.931] Timer tick, asking Buildbucket for the build status
[07:04:21.184] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:21.184] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:61:0) after 1m0s
[07:05:21.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:61:0)
[07:05:21.253] Timer tick, asking Buildbucket for the build status
[07:05:23.594] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:23.594] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:62:0) after 1m0s
[07:06:23.796] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:62:0)
[07:06:23.796] Timer tick, asking Buildbucket for the build status
[07:06:24.109] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:24.109] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:63:0) after 1m0s
[07:07:24.201] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:63:0)
[07:07:24.201] Timer tick, asking Buildbucket for the build status
[07:07:24.561] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:24.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:64:0) after 1m0s
[07:08:24.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:64:0)
[07:08:24.622] Timer tick, asking Buildbucket for the build status
[07:08:24.759] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:24.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:65:0) after 1m0s
[07:09:24.779] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:65:0)
[07:09:24.779] Timer tick, asking Buildbucket for the build status
[07:09:24.915] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:24.915] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:66:0) after 1m0s
[07:10:24.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:66:0)
[07:10:24.936] Timer tick, asking Buildbucket for the build status
[07:10:26.658] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:26.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:67:0) after 1m0s
[07:11:26.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:67:0)
[07:11:26.679] Timer tick, asking Buildbucket for the build status
[07:11:27.411] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:68:0) after 1m0s
[07:12:27.432] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:68:0)
[07:12:27.432] Timer tick, asking Buildbucket for the build status
[07:12:27.762] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:27.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:69:0) after 1m0s
[07:13:27.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:69:0)
[07:13:27.783] Timer tick, asking Buildbucket for the build status
[07:13:28.499] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:28.499] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:70:0) after 1m0s
[07:14:28.521] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:70:0)
[07:14:28.521] Timer tick, asking Buildbucket for the build status
[07:14:29.843] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:29.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:71:0) after 1m0s
[07:15:29.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:71:0)
[07:15:29.869] Timer tick, asking Buildbucket for the build status
[07:15:31.002] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:31.002] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:72:0) after 1m0s
[07:16:31.011] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:72:0)
[07:16:31.011] Timer tick, asking Buildbucket for the build status
[07:16:32.486] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:32.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:73:0) after 1m0s
[07:17:32.573] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:73:0)
[07:17:32.573] Timer tick, asking Buildbucket for the build status
[07:17:33.536] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:33.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:74:0) after 1m0s
[07:18:33.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:74:0)
[07:18:33.612] Timer tick, asking Buildbucket for the build status
[07:18:34.015] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:34.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:75:0) after 1m0s
[07:19:34.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:75:0)
[07:19:34.054] Timer tick, asking Buildbucket for the build status
[07:19:34.283] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:34.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:76:0) after 1m0s
[07:20:34.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:76:0)
[07:20:34.281] Timer tick, asking Buildbucket for the build status
[07:20:34.816] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:34.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:77:0) after 1m0s
[07:21:34.941] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:77:0)
[07:21:34.941] Timer tick, asking Buildbucket for the build status
[07:21:37.286] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:37.286] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:78:0) after 1m0s
[07:22:37.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:78:0)
[07:22:37.264] Timer tick, asking Buildbucket for the build status
[07:22:37.500] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:37.500] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:79:0) after 1m0s
[07:23:37.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:79:0)
[07:23:37.556] Timer tick, asking Buildbucket for the build status
[07:23:38.173] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:38.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:80:0) after 1m0s
[07:24:38.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:80:0)
[07:24:38.217] Timer tick, asking Buildbucket for the build status
[07:24:38.477] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:38.477] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:81:0) after 1m0s
[07:25:38.504] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:81:0)
[07:25:38.504] Timer tick, asking Buildbucket for the build status
[07:25:38.609] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:38.609] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:82:0) after 1m0s
[07:26:38.666] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:82:0)
[07:26:38.666] Timer tick, asking Buildbucket for the build status
[07:26:40.436] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:40.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:83:0) after 1m0s
[07:27:40.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:83:0)
[07:27:40.459] Timer tick, asking Buildbucket for the build status
[07:27:40.559] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:40.559] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:84:0) after 1m0s
[07:28:40.580] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:84:0)
[07:28:40.580] Timer tick, asking Buildbucket for the build status
[07:28:40.840] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:40.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:85:0) after 1m0s
[07:29:40.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:85:0)
[07:29:40.868] Timer tick, asking Buildbucket for the build status
[07:29:41.022] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:86:0) after 1m0s
[07:30:41.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:86:0)
[07:30:41.055] Timer tick, asking Buildbucket for the build status
[07:30:41.353] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:41.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:87:0) after 1m0s
[07:31:41.402] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:87:0)
[07:31:41.402] Timer tick, asking Buildbucket for the build status
[07:31:42.027] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:42.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:88:0) after 1m0s
[07:32:42.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:88:0)
[07:32:42.064] Timer tick, asking Buildbucket for the build status
[07:32:43.017] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:43.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:89:0) after 1m0s
[07:33:43.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:89:0)
[07:33:43.037] Timer tick, asking Buildbucket for the build status
[07:33:43.400] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:43.400] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:90:0) after 1m0s
[07:34:43.767] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:90:0)
[07:34:43.767] Timer tick, asking Buildbucket for the build status
[07:34:45.131] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:45.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:91:0) after 1m0s
[07:35:45.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:91:0)
[07:35:45.169] Timer tick, asking Buildbucket for the build status
[07:35:45.368] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:45.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:92:0) after 1m0s
[07:36:45.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:92:0)
[07:36:45.395] Timer tick, asking Buildbucket for the build status
[07:36:45.535] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:45.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:93:0) after 1m0s
[07:37:45.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:93:0)
[07:37:45.607] Timer tick, asking Buildbucket for the build status
[07:37:46.486] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:46.486] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:94:0) after 1m0s
[07:38:46.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:94:0)
[07:38:46.608] Timer tick, asking Buildbucket for the build status
[07:38:48.119] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:48.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:95:0) after 1m0s
[07:39:48.145] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:95:0)
[07:39:48.145] Timer tick, asking Buildbucket for the build status
[07:39:48.237] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:48.237] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:96:0) after 1m0s
[07:40:48.256] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:96:0)
[07:40:48.256] Timer tick, asking Buildbucket for the build status
[07:40:48.783] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:48.783] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:97:0) after 1m0s
[07:41:48.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:97:0)
[07:41:48.808] Timer tick, asking Buildbucket for the build status
[07:41:48.971] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:48.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:98:0) after 1m0s
[07:42:50.066] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:98:0)
[07:42:50.066] Timer tick, asking Buildbucket for the build status
[07:42:50.695] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:50.695] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:99:0) after 1m0s
[07:43:50.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:99:0)
[07:43:50.677] Timer tick, asking Buildbucket for the build status
[07:43:51.359] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:51.359] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:100:0) after 1m0s
[07:44:51.382] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:100:0)
[07:44:51.382] Timer tick, asking Buildbucket for the build status
[07:44:51.656] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:51.656] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:101:0) after 1m0s
[07:45:51.774] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:101:0)
[07:45:51.774] Timer tick, asking Buildbucket for the build status
[07:45:51.980] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:51.980] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:102:0) after 1m0s
[07:46:52.168] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:102:0)
[07:46:52.168] Timer tick, asking Buildbucket for the build status
[07:46:52.786] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:52.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:103:0) after 1m0s
[07:47:52.821] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:103:0)
[07:47:52.821] Timer tick, asking Buildbucket for the build status
[07:47:53.982] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:53.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:104:0) after 1m0s
[07:48:54.004] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:104:0)
[07:48:54.004] Timer tick, asking Buildbucket for the build status
[07:48:54.645] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:54.645] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:105:0) after 1m0s
[07:49:54.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:105:0)
[07:49:54.670] Timer tick, asking Buildbucket for the build status
[07:49:55.935] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:55.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:106:0) after 1m0s
[07:50:55.957] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:106:0)
[07:50:55.957] Timer tick, asking Buildbucket for the build status
[07:50:56.145] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:107:0) after 1m0s
[07:51:56.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:107:0)
[07:51:56.170] Timer tick, asking Buildbucket for the build status
[07:51:56.562] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:56.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:108:0) after 1m0s
[07:52:56.672] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:108:0)
[07:52:56.672] Timer tick, asking Buildbucket for the build status
[07:52:57.098] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:57.098] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:109:0) after 1m0s
[07:53:57.128] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:109:0)
[07:53:57.128] Timer tick, asking Buildbucket for the build status
[07:53:59.785] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:59.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:110:0) after 1m0s
[07:54:59.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:110:0)
[07:54:59.873] Timer tick, asking Buildbucket for the build status
[07:55:00.593] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:00.593] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:111:0) after 1m0s
[07:56:00.595] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:111:0)
[07:56:00.595] Timer tick, asking Buildbucket for the build status
[07:56:00.765] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:00.765] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:112:0) after 1m0s
[07:57:00.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:112:0)
[07:57:00.800] Timer tick, asking Buildbucket for the build status
[07:57:02.535] Build 8911061289864642960: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:02.535] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9076491352172784496:113:0) after 1m0s
[07:57:35.029] Received PubSub notification, asking Buildbucket for the build status
[07:57:35.294] Build 8911061289864642960: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:57:35.294] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1560153453121296",
"created_by": "project:chromium",
"created_ts": "1560146738142523",
"id": "8911061289864642960",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd3248750ececbce5df5d235aaac4477dae623d2\"}}",
"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-14-vc7q\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 23672, \"got_angle_revision\": \"2d0a9acb05511a8fdaf0cd27d0da22599516a68b\", \"got_dawn_revision\": \"7eb6be186be60a536a9f529b514bb5c5fd79293d\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"fd3248750ececbce5df5d235aaac4477dae623d2\", \"got_revision_cp\": \"refs/heads/master@{#667525}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"05e98a6eb753853cfbdabf257eba8cc633d5975f\", \"got_v8_revision_cp\": \"refs/heads/7.7.27@{#1}\", \"got_webrtc_revision\": \"54c9d89f69c50ae180e818528081404582a59a9c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28200}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"fd3248750ececbce5df5d235aaac4477dae623d2\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_344fdbb0645db34abb0ba2234526d11ebdee57216f7b28618f17626659f7ae86_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_9d027b9ed85f9043081db7bb96b179199582ec25322ad9498876811c19eebf55_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-14-vc7q\"], \"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\": [\"4332-2f8e532\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1560146783128578",
"status": "COMPLETED",
"status_changed_ts": "1560153453486995",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/23672",
"builder:Deterministic Linux",
"buildset:commit/git/fd3248750ececbce5df5d235aaac4477dae623d2",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fd3248750ececbce5df5d235aaac4477dae623d2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076491352172784496",
"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/8911061289864642960/+/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:4558cf8a3e1efe10",
"user_agent:luci-scheduler"
],
"updated_ts": "1560153453504309",
"url": "https://ci.chromium.org/b/8911061289864642960",
"utcnow_ts": "1560153455280291"
}
}
[07:57:35.294] Invocation finished in 1h51m58.737022246s with status SUCCEEDED