[00:41:24.531] New invocation is queued and will start shortly
[00:41:25.661] Starting the invocation (attempt 1)
[00:41:25.701] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:41:25.701] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:41:25.701] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9066546082845472672",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d0b11f7329a4c54e591033637232763d099cc950\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9066546082845472672",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/d0b11f7329a4c54e591033637232763d099cc950",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0b11f7329a4c54e591033637232763d099cc950",
"gitiles_ref:refs/heads/master"
]
}
[00:41:26.705] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1569631285948967",
"id": "8901116020664204080",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d0b11f7329a4c54e591033637232763d099cc950\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1569631286499104",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24949",
"builder:Deterministic Linux",
"buildset:commit/git/d0b11f7329a4c54e591033637232763d099cc950",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0b11f7329a4c54e591033637232763d099cc950",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066546082845472672",
"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/8901116020664204080/+/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": "1569631286499213",
"url": "https://ci.chromium.org/b/8901116020664204080",
"utcnow_ts": "1569631286694379"
}
}
[00:41:26.705] Task URL: https://ci.chromium.org/b/8901116020664204080
[00:41:26.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:2:0) after 1m0s
[00:42:24.597] Received PubSub notification, asking Buildbucket for the build status
[00:42:25.053] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:26.720] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:2:0)
[00:42:26.720] Timer tick, asking Buildbucket for the build status
[00:42:30.553] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:30.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:4:0) after 1m0s
[00:43:30.718] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:4:0)
[00:43:30.718] Timer tick, asking Buildbucket for the build status
[00:43:31.132] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:31.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:5:0) after 1m0s
[00:44:31.124] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:5:0)
[00:44:31.124] Timer tick, asking Buildbucket for the build status
[00:44:31.516] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:31.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:6:0) after 1m0s
[00:45:31.550] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:6:0)
[00:45:31.550] Timer tick, asking Buildbucket for the build status
[00:45:33.684] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:33.684] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:7:0) after 1m0s
[00:46:33.708] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:7:0)
[00:46:33.708] Timer tick, asking Buildbucket for the build status
[00:46:47.892] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:47.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:8:0) after 1m0s
[00:47:47.999] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:8:0)
[00:47:47.999] Timer tick, asking Buildbucket for the build status
[00:47:49.982] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:49.982] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:9:0) after 1m0s
[00:48:49.984] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:9:0)
[00:48:49.984] Timer tick, asking Buildbucket for the build status
[00:48:50.194] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:50.194] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:10:0) after 1m0s
[00:49:50.331] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:10:0)
[00:49:50.331] Timer tick, asking Buildbucket for the build status
[00:49:50.838] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:50.838] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:11:0) after 1m0s
[00:50:50.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:11:0)
[00:50:50.838] Timer tick, asking Buildbucket for the build status
[00:50:51.035] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:51.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:12:0) after 1m0s
[00:51:51.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:12:0)
[00:51:51.138] Timer tick, asking Buildbucket for the build status
[00:51:51.798] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:51.798] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:13:0) after 1m0s
[00:52:51.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:13:0)
[00:52:51.895] Timer tick, asking Buildbucket for the build status
[00:52:52.132] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:52.132] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:14:0) after 1m0s
[00:53:52.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:14:0)
[00:53:52.172] Timer tick, asking Buildbucket for the build status
[00:53:52.786] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:52.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:15:0) after 1m0s
[00:54:52.979] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:15:0)
[00:54:52.979] Timer tick, asking Buildbucket for the build status
[00:54:54.506] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:54.506] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:16:0) after 1m0s
[00:55:54.637] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:16:0)
[00:55:54.637] Timer tick, asking Buildbucket for the build status
[00:55:55.428] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:55.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:17:0) after 1m0s
[00:56:55.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:17:0)
[00:56:55.638] Timer tick, asking Buildbucket for the build status
[00:56:58.100] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:58.100] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:18:0) after 1m0s
[00:57:58.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:18:0)
[00:57:58.113] Timer tick, asking Buildbucket for the build status
[00:57:59.155] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:59.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:19:0) after 1m0s
[00:58:59.698] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:19:0)
[00:58:59.698] Timer tick, asking Buildbucket for the build status
[00:59:03.231] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:03.231] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:20:0) after 1m0s
[01:00:03.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:20:0)
[01:00:03.304] Timer tick, asking Buildbucket for the build status
[01:00:04.054] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:04.054] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:21:0) after 1m0s
[01:01:04.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:21:0)
[01:01:04.392] Timer tick, asking Buildbucket for the build status
[01:01:04.572] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:04.572] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:22:0) after 1m0s
[01:02:05.649] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:22:0)
[01:02:05.649] Timer tick, asking Buildbucket for the build status
[01:02:08.216] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:08.216] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:23:0) after 1m0s
[01:03:08.844] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:23:0)
[01:03:08.844] Timer tick, asking Buildbucket for the build status
[01:03:11.897] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:11.897] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:24:0) after 1m0s
[01:04:12.051] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:24:0)
[01:04:12.051] Timer tick, asking Buildbucket for the build status
[01:04:14.859] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:14.859] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:25:0) after 1m0s
[01:05:15.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:25:0)
[01:05:15.114] Timer tick, asking Buildbucket for the build status
[01:05:15.476] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:26:0) after 1m0s
[01:06:15.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:26:0)
[01:06:15.503] Timer tick, asking Buildbucket for the build status
[01:06:15.760] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:15.760] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:27:0) after 1m0s
[01:07:15.756] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:27:0)
[01:07:15.756] Timer tick, asking Buildbucket for the build status
[01:07:16.097] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:16.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:28:0) after 1m0s
[01:08:16.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:28:0)
[01:08:16.138] Timer tick, asking Buildbucket for the build status
[01:08:17.882] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:17.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:29:0) after 1m0s
[01:09:17.940] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:29:0)
[01:09:17.940] Timer tick, asking Buildbucket for the build status
[01:09:18.337] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:18.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:30:0) after 1m0s
[01:10:18.319] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:30:0)
[01:10:18.319] Timer tick, asking Buildbucket for the build status
[01:10:20.794] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:31:0) after 1m0s
[01:11:20.929] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:31:0)
[01:11:20.929] Timer tick, asking Buildbucket for the build status
[01:11:21.879] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:21.879] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:32:0) after 1m0s
[01:12:21.904] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:32:0)
[01:12:21.904] Timer tick, asking Buildbucket for the build status
[01:12:25.369] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:25.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:33:0) after 1m0s
[01:13:25.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:33:0)
[01:13:25.473] Timer tick, asking Buildbucket for the build status
[01:13:29.294] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:29.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:34:0) after 1m0s
[01:14:29.333] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:34:0)
[01:14:29.333] Timer tick, asking Buildbucket for the build status
[01:14:29.646] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:29.646] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:35:0) after 1m0s
[01:15:29.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:35:0)
[01:15:29.740] Timer tick, asking Buildbucket for the build status
[01:15:32.013] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:32.013] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:36:0) after 1m0s
[01:16:32.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:36:0)
[01:16:32.111] Timer tick, asking Buildbucket for the build status
[01:16:35.354] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:35.354] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:37:0) after 1m0s
[01:17:35.405] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:37:0)
[01:17:35.405] Timer tick, asking Buildbucket for the build status
[01:17:35.600] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:35.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:38:0) after 1m0s
[01:18:35.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:38:0)
[01:18:35.688] Timer tick, asking Buildbucket for the build status
[01:18:39.548] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:39.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:39:0) after 1m0s
[01:19:39.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:39:0)
[01:19:39.650] Timer tick, asking Buildbucket for the build status
[01:19:40.935] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:40.935] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:40:0) after 1m0s
[01:20:40.962] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:40:0)
[01:20:40.962] Timer tick, asking Buildbucket for the build status
[01:20:41.232] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:41.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:41:0) after 1m0s
[01:21:41.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:41:0)
[01:21:41.312] Timer tick, asking Buildbucket for the build status
[01:21:44.524] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:44.524] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:42:0) after 1m0s
[01:22:44.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:42:0)
[01:22:44.647] Timer tick, asking Buildbucket for the build status
[01:22:46.104] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:46.104] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:43:0) after 1m0s
[01:23:46.219] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:43:0)
[01:23:46.219] Timer tick, asking Buildbucket for the build status
[01:23:48.452] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:48.452] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:44:0) after 1m0s
[01:24:48.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:44:0)
[01:24:48.543] Timer tick, asking Buildbucket for the build status
[01:24:52.411] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:52.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:45:0) after 1m0s
[01:25:52.438] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:45:0)
[01:25:52.438] Timer tick, asking Buildbucket for the build status
[01:25:52.696] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:52.696] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:46:0) after 1m0s
[01:26:52.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:46:0)
[01:26:52.700] Timer tick, asking Buildbucket for the build status
[01:26:54.418] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:54.418] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:47:0) after 1m0s
[01:27:54.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:47:0)
[01:27:54.473] Timer tick, asking Buildbucket for the build status
[01:27:54.691] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:54.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:48:0) after 1m0s
[01:28:54.719] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:48:0)
[01:28:54.719] Timer tick, asking Buildbucket for the build status
[01:28:57.407] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:57.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:49:0) after 1m0s
[01:29:57.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:49:0)
[01:29:57.476] Timer tick, asking Buildbucket for the build status
[01:29:59.545] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:59.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:50:0) after 1m0s
[01:30:59.561] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:50:0)
[01:30:59.561] Timer tick, asking Buildbucket for the build status
[01:30:59.800] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:59.800] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:51:0) after 1m0s
[01:31:59.866] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:51:0)
[01:31:59.866] Timer tick, asking Buildbucket for the build status
[01:32:01.007] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:01.007] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:52:0) after 1m0s
[01:33:01.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:52:0)
[01:33:01.041] Timer tick, asking Buildbucket for the build status
[01:33:02.097] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:02.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:53:0) after 1m0s
[01:34:02.153] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:53:0)
[01:34:02.153] Timer tick, asking Buildbucket for the build status
[01:34:02.845] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:54:0) after 1m0s
[01:35:02.905] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:54:0)
[01:35:02.905] Timer tick, asking Buildbucket for the build status
[01:35:06.282] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:06.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:55:0) after 1m0s
[01:36:06.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:55:0)
[01:36:06.346] Timer tick, asking Buildbucket for the build status
[01:36:06.542] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:06.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:56:0) after 1m0s
[01:37:06.636] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:56:0)
[01:37:06.636] Timer tick, asking Buildbucket for the build status
[01:37:08.390] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:08.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:57:0) after 1m0s
[01:38:08.513] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:57:0)
[01:38:08.513] Timer tick, asking Buildbucket for the build status
[01:38:12.697] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:12.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:58:0) after 1m0s
[01:39:12.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:58:0)
[01:39:12.726] Timer tick, asking Buildbucket for the build status
[01:39:13.953] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:13.953] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:59:0) after 1m0s
[01:40:13.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:59:0)
[01:40:13.978] Timer tick, asking Buildbucket for the build status
[01:40:18.732] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:18.732] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:60:0) after 1m0s
[01:41:18.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:60:0)
[01:41:18.757] Timer tick, asking Buildbucket for the build status
[01:41:22.650] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:22.650] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:61:0) after 1m0s
[01:42:22.780] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:61:0)
[01:42:22.780] Timer tick, asking Buildbucket for the build status
[01:42:23.644] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:23.644] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:62:0) after 1m0s
[01:43:23.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:62:0)
[01:43:23.676] Timer tick, asking Buildbucket for the build status
[01:43:23.942] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:23.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:63:0) after 1m0s
[01:44:24.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:63:0)
[01:44:24.014] Timer tick, asking Buildbucket for the build status
[01:44:26.334] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:26.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:64:0) after 1m0s
[01:45:26.503] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:64:0)
[01:45:26.503] Timer tick, asking Buildbucket for the build status
[01:45:28.067] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:28.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:65:0) after 1m0s
[01:46:28.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:65:0)
[01:46:28.124] Timer tick, asking Buildbucket for the build status
[01:46:31.212] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:31.212] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:66:0) after 1m0s
[01:47:31.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:66:0)
[01:47:31.364] Timer tick, asking Buildbucket for the build status
[01:47:32.520] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:32.520] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:67:0) after 1m0s
[01:48:32.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:67:0)
[01:48:32.581] Timer tick, asking Buildbucket for the build status
[01:48:32.757] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:32.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:68:0) after 1m0s
[01:49:32.829] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:68:0)
[01:49:32.829] Timer tick, asking Buildbucket for the build status
[01:49:35.436] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:35.436] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:69:0) after 1m0s
[01:50:35.555] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:69:0)
[01:50:35.555] Timer tick, asking Buildbucket for the build status
[01:50:35.731] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:35.731] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:70:0) after 1m0s
[01:51:35.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:70:0)
[01:51:35.813] Timer tick, asking Buildbucket for the build status
[01:51:40.868] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:40.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:71:0) after 1m0s
[01:52:40.887] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:71:0)
[01:52:40.887] Timer tick, asking Buildbucket for the build status
[01:52:41.721] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:41.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:72:0) after 1m0s
[01:53:41.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:72:0)
[01:53:41.766] Timer tick, asking Buildbucket for the build status
[01:53:42.891] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:42.891] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:73:0) after 1m0s
[01:54:42.988] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:73:0)
[01:54:42.988] Timer tick, asking Buildbucket for the build status
[01:54:43.700] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:43.700] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:74:0) after 1m0s
[01:55:43.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:74:0)
[01:55:43.762] Timer tick, asking Buildbucket for the build status
[01:55:44.860] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:44.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:75:0) after 1m0s
[01:56:44.885] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:75:0)
[01:56:44.885] Timer tick, asking Buildbucket for the build status
[01:56:46.691] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:46.691] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:76:0) after 1m0s
[01:57:46.728] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:76:0)
[01:57:46.728] Timer tick, asking Buildbucket for the build status
[01:57:47.949] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:47.949] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:77:0) after 1m0s
[01:58:48.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:77:0)
[01:58:48.151] Timer tick, asking Buildbucket for the build status
[01:58:48.582] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:48.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:78:0) after 1m0s
[01:59:48.632] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:78:0)
[01:59:48.632] Timer tick, asking Buildbucket for the build status
[01:59:50.402] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:50.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:79:0) after 1m0s
[02:00:50.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:79:0)
[02:00:50.456] Timer tick, asking Buildbucket for the build status
[02:00:50.809] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:50.809] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:80:0) after 1m0s
[02:01:50.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:80:0)
[02:01:50.869] Timer tick, asking Buildbucket for the build status
[02:01:51.442] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:51.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:81:0) after 1m0s
[02:02:51.572] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:81:0)
[02:02:51.573] Timer tick, asking Buildbucket for the build status
[02:02:52.939] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:52.940] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:82:0) after 1m0s
[02:03:53.029] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:82:0)
[02:03:53.030] Timer tick, asking Buildbucket for the build status
[02:03:53.529] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:53.529] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:83:0) after 1m0s
[02:04:53.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:83:0)
[02:04:53.531] Timer tick, asking Buildbucket for the build status
[02:04:53.756] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:53.756] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:84:0) after 1m0s
[02:05:53.848] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:84:0)
[02:05:53.848] Timer tick, asking Buildbucket for the build status
[02:05:56.349] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:56.349] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:85:0) after 1m0s
[02:06:56.327] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:85:0)
[02:06:56.327] Timer tick, asking Buildbucket for the build status
[02:06:56.550] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:56.550] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:86:0) after 1m0s
[02:07:56.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:86:0)
[02:07:56.741] Timer tick, asking Buildbucket for the build status
[02:08:03.441] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:03.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:87:0) after 1m0s
[02:09:03.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:87:0)
[02:09:03.431] Timer tick, asking Buildbucket for the build status
[02:09:03.794] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.794] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:88:0) after 1m0s
[02:10:03.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:88:0)
[02:10:03.965] Timer tick, asking Buildbucket for the build status
[02:10:08.145] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:08.145] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:89:0) after 1m0s
[02:11:08.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:89:0)
[02:11:08.297] Timer tick, asking Buildbucket for the build status
[02:11:08.747] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:90:0) after 1m0s
[02:12:08.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:90:0)
[02:12:08.804] Timer tick, asking Buildbucket for the build status
[02:12:09.063] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:09.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:91:0) after 1m0s
[02:13:09.188] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:91:0)
[02:13:09.188] Timer tick, asking Buildbucket for the build status
[02:13:09.505] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:09.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:92:0) after 1m0s
[02:14:09.531] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:92:0)
[02:14:09.531] Timer tick, asking Buildbucket for the build status
[02:14:10.541] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:10.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:93:0) after 1m0s
[02:15:10.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:93:0)
[02:15:10.612] Timer tick, asking Buildbucket for the build status
[02:15:10.762] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:10.762] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:94:0) after 1m0s
[02:16:10.818] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:94:0)
[02:16:10.818] Timer tick, asking Buildbucket for the build status
[02:16:13.173] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:13.173] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:95:0) after 1m0s
[02:17:13.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:95:0)
[02:17:13.228] Timer tick, asking Buildbucket for the build status
[02:17:13.434] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:13.434] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:96:0) after 1m0s
[02:18:13.527] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:96:0)
[02:18:13.527] Timer tick, asking Buildbucket for the build status
[02:18:13.957] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:13.957] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:97:0) after 1m0s
[02:19:13.995] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:97:0)
[02:19:13.995] Timer tick, asking Buildbucket for the build status
[02:19:16.747] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:16.747] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:98:0) after 1m0s
[02:20:16.811] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:98:0)
[02:20:16.812] Timer tick, asking Buildbucket for the build status
[02:20:17.284] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:17.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:99:0) after 1m0s
[02:21:17.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:99:0)
[02:21:17.320] Timer tick, asking Buildbucket for the build status
[02:21:20.552] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:20.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:100:0) after 1m0s
[02:22:20.584] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:100:0)
[02:22:20.584] Timer tick, asking Buildbucket for the build status
[02:22:22.445] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:22.445] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:101:0) after 1m0s
[02:23:22.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:101:0)
[02:23:22.522] Timer tick, asking Buildbucket for the build status
[02:23:23.116] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:23.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:102:0) after 1m0s
[02:24:23.105] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:102:0)
[02:24:23.105] Timer tick, asking Buildbucket for the build status
[02:24:23.716] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:23.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:103:0) after 1m0s
[02:25:23.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:103:0)
[02:25:23.745] Timer tick, asking Buildbucket for the build status
[02:25:24.257] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:24.257] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:104:0) after 1m0s
[02:26:24.300] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:104:0)
[02:26:24.300] Timer tick, asking Buildbucket for the build status
[02:26:24.527] Build 8901116020664204080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:24.527] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9066546082845472672:105:0) after 1m0s
[02:27:17.530] Received PubSub notification, asking Buildbucket for the build status
[02:27:20.585] Build 8901116020664204080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[02:27:20.585] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1569637636338363",
"created_by": "project:chromium",
"created_ts": "1569631285948967",
"id": "8901116020664204080",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d0b11f7329a4c54e591033637232763d099cc950\"}}",
"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-xenial-us-east1-d-8-18-ov7y\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 24949, \"got_angle_revision\": \"a0159c03485b0ac91784d12d544927d83453d186\", \"got_dawn_revision\": \"f622a447500234810f3eb3aafff6358d7cff6628\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d0b11f7329a4c54e591033637232763d099cc950\", \"got_revision_cp\": \"refs/heads/master@{#700917}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"a90c7a9790fa743fe545bd348bdc45755f1d2117\", \"got_v8_revision_cp\": \"refs/heads/7.9.160@{#1}\", \"got_webrtc_revision\": \"ba2ba59c4ba1009ad04e56bb3804c882bc63441b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29331}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d0b11f7329a4c54e591033637232763d099cc950\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"builder_df0918bfe72974da8c562c0af785205b640d6f631f017829e032ab97ab701012_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-xenial-us-east1-d-8-18-ov7y\"], \"image\": [\"chrome-xenial-19090600-ed917d8233f\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4443-3a52fcb\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1569631343315845",
"status": "COMPLETED",
"status_changed_ts": "1569637636990873",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/24949",
"builder:Deterministic Linux",
"buildset:commit/git/d0b11f7329a4c54e591033637232763d099cc950",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0b11f7329a4c54e591033637232763d099cc950",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9066546082845472672",
"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/8901116020664204080/+/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:478e22d555532810",
"user_agent:luci-scheduler"
],
"updated_ts": "1569637637023289",
"url": "https://ci.chromium.org/b/8901116020664204080",
"utcnow_ts": "1569637640465801"
}
}
[02:27:20.585] Invocation finished in 1h45m56.10125235s with status SUCCEEDED