[15:07:38.305] New invocation is queued and will start shortly
[15:07:39.391] Starting the invocation (attempt 1)
[15:07:39.484] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:07:39.484] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:07:39.485] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9040309061073700400",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9040309061073700400",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"gitiles_ref:refs/heads/master"
]
}
[15:07:40.430] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1594652859588043",
"id": "8874878999062551920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594652860216503",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28529",
"builder:Deterministic Linux",
"buildset:commit/git/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040309061073700400",
"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/8874878999062551920/+/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": "1594652860216647",
"url": "https://ci.chromium.org/b/8874878999062551920",
"utcnow_ts": "1594652860406704"
}
}
[15:07:40.430] Task URL: https://ci.chromium.org/b/8874878999062551920
[15:07:40.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:2:0) after 1m0s
[15:07:46.361] Received PubSub notification, asking Buildbucket for the build status
[15:07:46.442] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:40.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:2:0)
[15:08:40.505] Timer tick, asking Buildbucket for the build status
[15:08:40.654] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:40.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:4:0) after 1m0s
[15:09:40.699] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:4:0)
[15:09:40.699] Timer tick, asking Buildbucket for the build status
[15:09:40.806] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:40.806] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:5:0) after 1m0s
[15:10:40.964] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:5:0)
[15:10:40.964] Timer tick, asking Buildbucket for the build status
[15:10:41.140] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:41.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:6:0) after 1m0s
[15:11:41.352] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:6:0)
[15:11:41.352] Timer tick, asking Buildbucket for the build status
[15:11:41.523] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:41.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:7:0) after 1m0s
[15:12:41.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:7:0)
[15:12:41.557] Timer tick, asking Buildbucket for the build status
[15:12:41.671] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:41.671] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:8:0) after 1m0s
[15:13:41.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:8:0)
[15:13:41.778] Timer tick, asking Buildbucket for the build status
[15:13:42.003] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:42.004] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:9:0) after 1m0s
[15:14:42.133] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:9:0)
[15:14:42.133] Timer tick, asking Buildbucket for the build status
[15:14:42.304] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:42.304] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:10:0) after 1m0s
[15:15:43.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:10:0)
[15:15:43.218] Timer tick, asking Buildbucket for the build status
[15:15:43.491] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:43.491] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:11:0) after 1m0s
[15:16:43.609] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:11:0)
[15:16:43.609] Timer tick, asking Buildbucket for the build status
[15:16:43.787] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:43.787] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:12:0) after 1m0s
[15:17:43.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:12:0)
[15:17:43.878] Timer tick, asking Buildbucket for the build status
[15:17:44.021] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:13:0) after 1m0s
[15:18:44.272] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:13:0)
[15:18:44.272] Timer tick, asking Buildbucket for the build status
[15:18:44.839] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:44.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:14:0) after 1m0s
[15:19:44.951] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:14:0)
[15:19:44.951] Timer tick, asking Buildbucket for the build status
[15:19:45.397] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:45.398] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:15:0) after 1m0s
[15:20:45.435] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:15:0)
[15:20:45.435] Timer tick, asking Buildbucket for the build status
[15:20:46.023] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:46.023] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:16:0) after 1m0s
[15:21:46.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:16:0)
[15:21:46.195] Timer tick, asking Buildbucket for the build status
[15:21:47.051] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:47.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:17:0) after 1m0s
[15:22:47.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:17:0)
[15:22:47.259] Timer tick, asking Buildbucket for the build status
[15:22:47.658] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:47.658] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:18:0) after 1m0s
[15:23:47.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:18:0)
[15:23:47.751] Timer tick, asking Buildbucket for the build status
[15:23:47.927] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:47.927] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:19:0) after 1m0s
[15:24:47.955] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:19:0)
[15:24:47.955] Timer tick, asking Buildbucket for the build status
[15:24:48.152] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:20:0) after 1m0s
[15:25:48.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:20:0)
[15:25:48.162] Timer tick, asking Buildbucket for the build status
[15:25:48.261] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:48.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:21:0) after 1m0s
[15:26:48.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:21:0)
[15:26:48.347] Timer tick, asking Buildbucket for the build status
[15:26:48.873] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:48.873] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:22:0) after 1m0s
[15:27:48.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:22:0)
[15:27:48.936] Timer tick, asking Buildbucket for the build status
[15:27:49.092] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:49.092] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:23:0) after 1m0s
[15:28:49.239] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:23:0)
[15:28:49.239] Timer tick, asking Buildbucket for the build status
[15:28:49.393] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:49.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:24:0) after 1m0s
[15:29:49.487] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:24:0)
[15:29:49.487] Timer tick, asking Buildbucket for the build status
[15:29:49.921] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:49.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:25:0) after 1m0s
[15:30:49.956] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:25:0)
[15:30:49.956] Timer tick, asking Buildbucket for the build status
[15:30:50.089] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:50.089] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:26:0) after 1m0s
[15:31:50.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:26:0)
[15:31:50.178] Timer tick, asking Buildbucket for the build status
[15:31:50.338] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:50.338] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:27:0) after 1m0s
[15:32:50.479] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:27:0)
[15:32:50.479] Timer tick, asking Buildbucket for the build status
[15:32:50.598] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:50.598] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:28:0) after 1m0s
[15:33:50.645] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:28:0)
[15:33:50.645] Timer tick, asking Buildbucket for the build status
[15:33:50.852] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:50.852] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:29:0) after 1m0s
[15:34:50.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:29:0)
[15:34:50.922] Timer tick, asking Buildbucket for the build status
[15:34:51.064] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:51.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:30:0) after 1m0s
[15:35:51.132] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:30:0)
[15:35:51.132] Timer tick, asking Buildbucket for the build status
[15:35:51.316] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:51.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:31:0) after 1m0s
[15:36:51.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:31:0)
[15:36:51.391] Timer tick, asking Buildbucket for the build status
[15:36:51.517] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:51.517] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:32:0) after 1m0s
[15:37:51.575] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:32:0)
[15:37:51.575] Timer tick, asking Buildbucket for the build status
[15:37:51.777] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:51.777] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:33:0) after 1m0s
[15:38:51.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:33:0)
[15:38:51.800] Timer tick, asking Buildbucket for the build status
[15:38:52.248] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:52.248] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:34:0) after 1m0s
[15:39:52.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:34:0)
[15:39:52.244] Timer tick, asking Buildbucket for the build status
[15:39:52.454] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:52.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:35:0) after 1m0s
[15:40:52.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:35:0)
[15:40:52.558] Timer tick, asking Buildbucket for the build status
[15:40:52.739] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:52.739] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:36:0) after 1m0s
[15:41:52.819] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:36:0)
[15:41:52.819] Timer tick, asking Buildbucket for the build status
[15:41:53.009] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:53.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:37:0) after 1m0s
[15:42:53.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:37:0)
[15:42:53.083] Timer tick, asking Buildbucket for the build status
[15:42:53.240] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:53.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:38:0) after 1m0s
[15:43:53.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:38:0)
[15:43:53.268] Timer tick, asking Buildbucket for the build status
[15:43:53.408] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:53.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:39:0) after 1m0s
[15:44:53.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:39:0)
[15:44:53.486] Timer tick, asking Buildbucket for the build status
[15:44:53.672] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:53.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:40:0) after 1m0s
[15:45:54.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:40:0)
[15:45:54.646] Timer tick, asking Buildbucket for the build status
[15:45:54.819] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:54.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:41:0) after 1m0s
[15:46:54.847] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:41:0)
[15:46:54.847] Timer tick, asking Buildbucket for the build status
[15:46:55.085] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:55.085] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:42:0) after 1m0s
[15:47:55.109] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:42:0)
[15:47:55.111] Timer tick, asking Buildbucket for the build status
[15:47:55.819] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:55.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:43:0) after 1m0s
[15:48:55.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:43:0)
[15:48:55.843] Timer tick, asking Buildbucket for the build status
[15:48:56.063] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:56.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:44:0) after 1m0s
[15:49:56.120] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:44:0)
[15:49:56.120] Timer tick, asking Buildbucket for the build status
[15:49:56.808] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:56.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:45:0) after 1m0s
[15:50:56.868] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:45:0)
[15:50:56.868] Timer tick, asking Buildbucket for the build status
[15:50:57.036] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:57.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:46:0) after 1m0s
[15:51:57.064] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:46:0)
[15:51:57.064] Timer tick, asking Buildbucket for the build status
[15:51:57.247] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:57.247] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:47:0) after 1m0s
[15:52:57.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:47:0)
[15:52:57.232] Timer tick, asking Buildbucket for the build status
[15:52:57.385] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:57.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:48:0) after 1m0s
[15:53:57.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:48:0)
[15:53:57.453] Timer tick, asking Buildbucket for the build status
[15:53:57.707] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:57.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:49:0) after 1m0s
[15:54:57.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:49:0)
[15:54:57.744] Timer tick, asking Buildbucket for the build status
[15:54:57.888] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:57.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:50:0) after 1m0s
[15:55:57.952] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:50:0)
[15:55:57.952] Timer tick, asking Buildbucket for the build status
[15:55:58.385] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:58.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:51:0) after 1m0s
[15:56:58.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:51:0)
[15:56:58.451] Timer tick, asking Buildbucket for the build status
[15:56:58.670] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:58.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:52:0) after 1m0s
[15:57:58.682] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:52:0)
[15:57:58.682] Timer tick, asking Buildbucket for the build status
[15:57:58.834] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:58.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:53:0) after 1m0s
[15:58:58.915] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:53:0)
[15:58:58.915] Timer tick, asking Buildbucket for the build status
[15:58:59.068] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:59.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:54:0) after 1m0s
[15:59:59.058] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:54:0)
[15:59:59.059] Timer tick, asking Buildbucket for the build status
[15:59:59.240] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:59.240] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:55:0) after 1m0s
[16:00:59.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:55:0)
[16:00:59.295] Timer tick, asking Buildbucket for the build status
[16:00:59.552] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:59.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:56:0) after 1m0s
[16:01:59.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:56:0)
[16:01:59.611] Timer tick, asking Buildbucket for the build status
[16:01:59.902] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:59.902] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:57:0) after 1m0s
[16:02:59.899] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:57:0)
[16:02:59.899] Timer tick, asking Buildbucket for the build status
[16:03:00.152] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:00.152] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:58:0) after 1m0s
[16:04:00.183] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:58:0)
[16:04:00.183] Timer tick, asking Buildbucket for the build status
[16:04:00.415] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:00.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:59:0) after 1m0s
[16:05:00.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:59:0)
[16:05:00.473] Timer tick, asking Buildbucket for the build status
[16:05:01.227] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:01.227] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:60:0) after 1m0s
[16:06:01.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:60:0)
[16:06:01.445] Timer tick, asking Buildbucket for the build status
[16:06:01.601] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:01.601] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:61:0) after 1m0s
[16:07:01.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:61:0)
[16:07:01.663] Timer tick, asking Buildbucket for the build status
[16:07:01.884] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:01.884] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:62:0) after 1m0s
[16:08:02.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:62:0)
[16:08:02.398] Timer tick, asking Buildbucket for the build status
[16:08:02.545] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:02.545] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:63:0) after 1m0s
[16:09:02.571] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:63:0)
[16:09:02.571] Timer tick, asking Buildbucket for the build status
[16:09:04.704] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:04.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:64:0) after 1m0s
[16:10:04.731] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:64:0)
[16:10:04.731] Timer tick, asking Buildbucket for the build status
[16:10:04.903] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:04.903] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:65:0) after 1m0s
[16:11:04.978] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:65:0)
[16:11:04.978] Timer tick, asking Buildbucket for the build status
[16:11:05.899] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:05.899] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:66:0) after 1m0s
[16:12:05.948] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:66:0)
[16:12:05.948] Timer tick, asking Buildbucket for the build status
[16:12:06.170] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:06.170] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:67:0) after 1m0s
[16:13:06.221] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:67:0)
[16:13:06.221] Timer tick, asking Buildbucket for the build status
[16:13:06.374] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:06.374] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:68:0) after 1m0s
[16:14:06.787] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:68:0)
[16:14:06.787] Timer tick, asking Buildbucket for the build status
[16:14:06.970] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:06.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:69:0) after 1m0s
[16:15:07.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:69:0)
[16:15:07.076] Timer tick, asking Buildbucket for the build status
[16:15:07.407] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:07.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:70:0) after 1m0s
[16:16:07.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:70:0)
[16:16:07.522] Timer tick, asking Buildbucket for the build status
[16:16:07.907] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:07.907] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:71:0) after 1m0s
[16:17:08.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:71:0)
[16:17:08.049] Timer tick, asking Buildbucket for the build status
[16:17:08.565] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:08.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:72:0) after 1m0s
[16:18:08.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:72:0)
[16:18:08.676] Timer tick, asking Buildbucket for the build status
[16:18:08.890] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:08.890] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:73:0) after 1m0s
[16:19:08.937] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:73:0)
[16:19:08.937] Timer tick, asking Buildbucket for the build status
[16:19:09.107] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:09.107] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:74:0) after 1m0s
[16:20:09.149] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:74:0)
[16:20:09.149] Timer tick, asking Buildbucket for the build status
[16:20:09.285] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:09.285] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:75:0) after 1m0s
[16:21:09.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:75:0)
[16:21:09.337] Timer tick, asking Buildbucket for the build status
[16:21:09.483] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:09.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:76:0) after 1m0s
[16:22:09.619] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:76:0)
[16:22:09.619] Timer tick, asking Buildbucket for the build status
[16:22:09.808] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:09.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:77:0) after 1m0s
[16:23:09.838] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:77:0)
[16:23:09.838] Timer tick, asking Buildbucket for the build status
[16:23:10.246] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:10.246] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:78:0) after 1m0s
[16:24:10.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:78:0)
[16:24:10.624] Timer tick, asking Buildbucket for the build status
[16:24:10.786] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:10.786] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:79:0) after 1m0s
[16:25:10.899] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:79:0)
[16:25:10.899] Timer tick, asking Buildbucket for the build status
[16:25:11.152] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:11.153] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:80:0) after 1m0s
[16:26:11.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:80:0)
[16:26:11.169] Timer tick, asking Buildbucket for the build status
[16:26:11.647] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:11.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:81:0) after 1m0s
[16:27:11.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:81:0)
[16:27:11.748] Timer tick, asking Buildbucket for the build status
[16:27:12.003] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:12.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:82:0) after 1m0s
[16:28:12.877] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:82:0)
[16:28:12.877] Timer tick, asking Buildbucket for the build status
[16:28:13.133] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:13.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:83:0) after 1m0s
[16:29:13.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:83:0)
[16:29:13.208] Timer tick, asking Buildbucket for the build status
[16:29:13.352] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:13.352] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:84:0) after 1m0s
[16:30:13.422] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:84:0)
[16:30:13.422] Timer tick, asking Buildbucket for the build status
[16:30:13.620] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:13.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:85:0) after 1m0s
[16:31:13.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:85:0)
[16:31:13.648] Timer tick, asking Buildbucket for the build status
[16:31:14.106] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:14.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:86:0) after 1m0s
[16:32:14.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:86:0)
[16:32:14.206] Timer tick, asking Buildbucket for the build status
[16:32:14.393] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:14.393] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:87:0) after 1m0s
[16:33:14.452] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:87:0)
[16:33:14.453] Timer tick, asking Buildbucket for the build status
[16:33:14.607] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:14.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:88:0) after 1m0s
[16:34:14.627] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:88:0)
[16:34:14.627] Timer tick, asking Buildbucket for the build status
[16:34:15.066] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:15.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:89:0) after 1m0s
[16:35:15.210] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:89:0)
[16:35:15.210] Timer tick, asking Buildbucket for the build status
[16:35:15.505] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:15.505] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:90:0) after 1m0s
[16:36:15.651] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:90:0)
[16:36:15.651] Timer tick, asking Buildbucket for the build status
[16:36:16.789] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:16.789] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:91:0) after 1m0s
[16:37:16.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:91:0)
[16:37:16.839] Timer tick, asking Buildbucket for the build status
[16:37:17.154] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:17.154] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:92:0) after 1m0s
[16:38:17.320] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:92:0)
[16:38:17.321] Timer tick, asking Buildbucket for the build status
[16:38:17.643] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:17.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:93:0) after 1m0s
[16:39:17.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:93:0)
[16:39:17.777] Timer tick, asking Buildbucket for the build status
[16:39:18.172] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:18.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:94:0) after 1m0s
[16:40:18.233] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:94:0)
[16:40:18.233] Timer tick, asking Buildbucket for the build status
[16:40:18.539] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:18.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:95:0) after 1m0s
[16:41:18.965] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:95:0)
[16:41:18.965] Timer tick, asking Buildbucket for the build status
[16:41:19.106] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:19.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:96:0) after 1m0s
[16:42:19.163] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:96:0)
[16:42:19.163] Timer tick, asking Buildbucket for the build status
[16:42:19.426] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:19.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:97:0) after 1m0s
[16:43:19.519] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:97:0)
[16:43:19.519] Timer tick, asking Buildbucket for the build status
[16:43:20.946] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:98:0) after 1m0s
[16:44:21.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:98:0)
[16:44:21.014] Timer tick, asking Buildbucket for the build status
[16:44:21.168] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:21.168] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:99:0) after 1m0s
[16:45:21.316] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:99:0)
[16:45:21.316] Timer tick, asking Buildbucket for the build status
[16:45:21.488] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:21.488] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:100:0) after 1m0s
[16:46:21.508] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:100:0)
[16:46:21.508] Timer tick, asking Buildbucket for the build status
[16:46:21.669] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:21.669] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:101:0) after 1m0s
[16:47:21.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:101:0)
[16:47:21.741] Timer tick, asking Buildbucket for the build status
[16:47:21.970] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:21.970] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:102:0) after 1m0s
[16:48:21.996] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:102:0)
[16:48:21.996] Timer tick, asking Buildbucket for the build status
[16:48:22.103] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:22.103] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:103:0) after 1m0s
[16:49:22.151] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:103:0)
[16:49:22.151] Timer tick, asking Buildbucket for the build status
[16:49:22.325] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:22.325] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:104:0) after 1m0s
[16:50:22.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:104:0)
[16:50:22.362] Timer tick, asking Buildbucket for the build status
[16:50:23.070] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:23.070] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:105:0) after 1m0s
[16:51:23.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:105:0)
[16:51:23.208] Timer tick, asking Buildbucket for the build status
[16:51:23.701] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:23.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:106:0) after 1m0s
[16:52:23.832] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:106:0)
[16:52:23.832] Timer tick, asking Buildbucket for the build status
[16:52:24.181] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:24.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:107:0) after 1m0s
[16:53:24.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:107:0)
[16:53:24.261] Timer tick, asking Buildbucket for the build status
[16:53:24.432] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:24.432] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:108:0) after 1m0s
[16:54:24.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:108:0)
[16:54:24.464] Timer tick, asking Buildbucket for the build status
[16:54:24.887] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:24.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:109:0) after 1m0s
[16:55:24.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:109:0)
[16:55:24.920] Timer tick, asking Buildbucket for the build status
[16:55:25.042] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:25.043] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:110:0) after 1m0s
[16:56:25.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:110:0)
[16:56:25.022] Timer tick, asking Buildbucket for the build status
[16:56:25.144] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:25.144] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:111:0) after 1m0s
[16:57:25.206] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:111:0)
[16:57:25.206] Timer tick, asking Buildbucket for the build status
[16:57:25.361] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:25.361] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:112:0) after 1m0s
[16:58:25.646] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:112:0)
[16:58:25.646] Timer tick, asking Buildbucket for the build status
[16:58:26.387] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:26.387] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:113:0) after 1m0s
[16:59:26.725] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:113:0)
[16:59:26.725] Timer tick, asking Buildbucket for the build status
[16:59:26.988] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:26.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:114:0) after 1m0s
[17:00:27.279] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:114:0)
[17:00:27.279] Timer tick, asking Buildbucket for the build status
[17:00:27.515] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:27.515] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:115:0) after 1m0s
[17:01:27.617] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:115:0)
[17:01:27.617] Timer tick, asking Buildbucket for the build status
[17:01:27.738] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:27.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:116:0) after 1m0s
[17:02:27.777] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:116:0)
[17:02:27.777] Timer tick, asking Buildbucket for the build status
[17:02:27.971] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:27.972] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:117:0) after 1m0s
[17:03:28.199] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:117:0)
[17:03:28.199] Timer tick, asking Buildbucket for the build status
[17:03:28.353] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:28.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:118:0) after 1m0s
[17:04:28.614] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:118:0)
[17:04:28.614] Timer tick, asking Buildbucket for the build status
[17:04:30.634] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:30.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:119:0) after 1m0s
[17:05:30.928] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:119:0)
[17:05:30.928] Timer tick, asking Buildbucket for the build status
[17:05:31.278] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:31.278] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:120:0) after 1m0s
[17:06:31.306] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:120:0)
[17:06:31.306] Timer tick, asking Buildbucket for the build status
[17:06:31.438] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:31.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:121:0) after 1m0s
[17:07:31.526] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:121:0)
[17:07:31.526] Timer tick, asking Buildbucket for the build status
[17:07:31.668] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:31.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:122:0) after 1m0s
[17:08:31.689] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:122:0)
[17:08:31.689] Timer tick, asking Buildbucket for the build status
[17:08:32.191] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:32.191] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:123:0) after 1m0s
[17:09:32.454] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:123:0)
[17:09:32.454] Timer tick, asking Buildbucket for the build status
[17:09:32.602] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:32.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:124:0) after 1m0s
[17:10:32.740] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:124:0)
[17:10:32.740] Timer tick, asking Buildbucket for the build status
[17:10:33.032] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:33.032] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:125:0) after 1m0s
[17:11:33.081] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:125:0)
[17:11:33.081] Timer tick, asking Buildbucket for the build status
[17:11:33.384] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:33.384] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:126:0) after 1m0s
[17:12:33.471] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:126:0)
[17:12:33.471] Timer tick, asking Buildbucket for the build status
[17:12:33.612] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:33.612] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:127:0) after 1m0s
[17:13:33.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:127:0)
[17:13:33.680] Timer tick, asking Buildbucket for the build status
[17:13:33.814] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:33.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:128:0) after 1m0s
[17:14:33.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:128:0)
[17:14:33.839] Timer tick, asking Buildbucket for the build status
[17:14:35.402] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:35.402] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:129:0) after 1m0s
[17:15:35.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:129:0)
[17:15:35.477] Timer tick, asking Buildbucket for the build status
[17:15:35.757] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:35.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:130:0) after 1m0s
[17:16:35.987] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:130:0)
[17:16:35.987] Timer tick, asking Buildbucket for the build status
[17:16:36.856] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:36.856] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:131:0) after 1m0s
[17:17:36.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:131:0)
[17:17:36.986] Timer tick, asking Buildbucket for the build status
[17:17:37.218] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:37.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:132:0) after 1m0s
[17:18:37.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:132:0)
[17:18:37.269] Timer tick, asking Buildbucket for the build status
[17:18:38.316] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:38.316] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:133:0) after 1m0s
[17:19:38.388] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:133:0)
[17:19:38.388] Timer tick, asking Buildbucket for the build status
[17:19:39.385] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:39.385] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:134:0) after 1m0s
[17:20:39.431] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:134:0)
[17:20:39.431] Timer tick, asking Buildbucket for the build status
[17:20:39.720] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:39.720] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:135:0) after 1m0s
[17:21:39.749] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:135:0)
[17:21:39.749] Timer tick, asking Buildbucket for the build status
[17:21:41.523] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:41.523] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:136:0) after 1m0s
[17:22:41.707] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:136:0)
[17:22:41.707] Timer tick, asking Buildbucket for the build status
[17:22:41.887] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:41.887] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:137:0) after 1m0s
[17:23:42.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:137:0)
[17:23:42.103] Timer tick, asking Buildbucket for the build status
[17:23:42.539] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:42.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:138:0) after 1m0s
[17:24:42.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:138:0)
[17:24:42.608] Timer tick, asking Buildbucket for the build status
[17:24:44.850] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:44.850] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:139:0) after 1m0s
[17:25:44.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:139:0)
[17:25:44.921] Timer tick, asking Buildbucket for the build status
[17:25:45.068] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:45.068] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:140:0) after 1m0s
[17:26:45.241] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:140:0)
[17:26:45.241] Timer tick, asking Buildbucket for the build status
[17:26:45.671] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:141:0) after 1m0s
[17:27:45.679] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:141:0)
[17:27:45.680] Timer tick, asking Buildbucket for the build status
[17:27:45.833] Build 8874878999062551920: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:45.833] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9040309061073700400:142:0) after 1m0s
[17:28:27.401] Received PubSub notification, asking Buildbucket for the build status
[17:28:27.504] Build 8874878999062551920: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:28:27.504] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1594661306407615",
"created_by": "project:chromium",
"created_ts": "1594652859588043",
"id": "8874878999062551920",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-33-485m\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 28529, \"got_angle_revision\": \"f3f891c5147106b84198e08975a09be1b2404c42\", \"got_dawn_revision\": \"b9285f69ba2c7a46eeb308a51689786deaf9ef1b\", \"got_nacl_revision\": \"fd20fafa8ec19700e12daa031bf792bae8b6bb21\", \"got_revision\": \"a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9\", \"got_revision_cp\": \"refs/heads/master@{#787725}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"ad65826a2ab181592473fb54ab78025771f4caf6\", \"got_v8_revision\": \"9329d03063bad3e90efc78062e27bc0cd6b9841d\", \"got_v8_revision_cp\": \"refs/heads/8.6.116@{#1}\", \"got_webrtc_revision\": \"8df59bc74ebb4d0b8e5d80a8b4f5c674db2a9c4d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31703}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-33-485m\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5378-e275056\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1594652865673512",
"status": "COMPLETED",
"status_changed_ts": "1594661307038932",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/28529",
"builder:Deterministic Linux",
"buildset:commit/git/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a21c7d9bb69a2b8caf2037cecdf4dba38724bdc9",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040309061073700400",
"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/8874878999062551920/+/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:4d61893548748410",
"user_agent:luci-scheduler"
],
"updated_ts": "1594661307047463",
"url": "https://ci.chromium.org/b/8874878999062551920",
"utcnow_ts": "1594661307494074"
}
}
[17:28:27.504] Invocation finished in 2h20m49.216882932s with status SUCCEEDED