[11:12:14.342] New invocation is queued and will start shortly
[11:12:15.534] Starting the invocation (attempt 1)
[11:12:15.581] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:12:15.581] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:12:15.581] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069314900368889648",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e295b3f239f4273003d8c1b1e6446a61433fca78\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9069314900368889648",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/e295b3f239f4273003d8c1b1e6446a61433fca78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e295b3f239f4273003d8c1b1e6446a61433fca78",
"gitiles_ref:refs/heads/master"
]
}
[11:12:18.377] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1566990737026875",
"id": "8903884836890627872",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e295b3f239f4273003d8c1b1e6446a61433fca78\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1566990738078792",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/10512",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/e295b3f239f4273003d8c1b1e6446a61433fca78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e295b3f239f4273003d8c1b1e6446a61433fca78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069314900368889648",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903884836890627872/+/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": "1566990738078923",
"url": "https://ci.chromium.org/b/8903884836890627872",
"utcnow_ts": "1566990738336358"
}
}
[11:12:18.377] Task URL: https://ci.chromium.org/b/8903884836890627872
[11:12:18.377] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:2:0) after 1m0s
[11:12:20.919] Received PubSub notification, asking Buildbucket for the build status
[11:12:21.711] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:18.464] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:2:0)
[11:13:18.464] Timer tick, asking Buildbucket for the build status
[11:13:18.987] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:18.987] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:4:0) after 1m0s
[11:14:19.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:4:0)
[11:14:19.053] Timer tick, asking Buildbucket for the build status
[11:14:19.425] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:19.425] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:5:0) after 1m0s
[11:15:19.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:5:0)
[11:15:19.445] Timer tick, asking Buildbucket for the build status
[11:15:20.035] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:20.035] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:6:0) after 1m0s
[11:16:20.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:6:0)
[11:16:20.087] Timer tick, asking Buildbucket for the build status
[11:16:20.383] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:20.383] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:7:0) after 1m0s
[11:17:20.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:7:0)
[11:17:20.532] Timer tick, asking Buildbucket for the build status
[11:17:22.373] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:22.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:8:0) after 1m0s
[11:18:22.394] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:8:0)
[11:18:22.394] Timer tick, asking Buildbucket for the build status
[11:18:22.630] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:22.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:9:0) after 1m0s
[11:19:22.744] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:9:0)
[11:19:22.744] Timer tick, asking Buildbucket for the build status
[11:19:23.584] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:23.584] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:10:0) after 1m0s
[11:20:23.558] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:10:0)
[11:20:23.558] Timer tick, asking Buildbucket for the build status
[11:20:23.967] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:23.968] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:11:0) after 1m0s
[11:21:24.106] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:11:0)
[11:21:24.106] Timer tick, asking Buildbucket for the build status
[11:21:24.738] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:12:0) after 1m0s
[11:22:24.784] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:12:0)
[11:22:24.784] Timer tick, asking Buildbucket for the build status
[11:22:24.979] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:24.979] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:13:0) after 1m0s
[11:23:25.018] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:13:0)
[11:23:25.018] Timer tick, asking Buildbucket for the build status
[11:23:25.229] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:25.229] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:14:0) after 1m0s
[11:24:25.284] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:14:0)
[11:24:25.284] Timer tick, asking Buildbucket for the build status
[11:24:26.717] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:26.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:15:0) after 1m0s
[11:25:26.836] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:15:0)
[11:25:26.836] Timer tick, asking Buildbucket for the build status
[11:25:27.099] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:27.099] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:16:0) after 1m0s
[11:26:27.135] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:16:0)
[11:26:27.135] Timer tick, asking Buildbucket for the build status
[11:26:27.958] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:27.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:17:0) after 1m0s
[11:27:27.976] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:17:0)
[11:27:27.977] Timer tick, asking Buildbucket for the build status
[11:27:28.218] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:28.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:18:0) after 1m0s
[11:28:28.304] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:18:0)
[11:28:28.304] Timer tick, asking Buildbucket for the build status
[11:28:29.036] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:29.036] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:19:0) after 1m0s
[11:29:29.182] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:19:0)
[11:29:29.182] Timer tick, asking Buildbucket for the build status
[11:29:29.757] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:29.757] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:20:0) after 1m0s
[11:30:30.050] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:20:0)
[11:30:30.050] Timer tick, asking Buildbucket for the build status
[11:30:30.261] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:21:0) after 1m0s
[11:31:30.453] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:21:0)
[11:31:30.453] Timer tick, asking Buildbucket for the build status
[11:31:30.629] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:30.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:22:0) after 1m0s
[11:32:30.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:22:0)
[11:32:30.813] Timer tick, asking Buildbucket for the build status
[11:32:31.706] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:31.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:23:0) after 1m0s
[11:33:31.824] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:23:0)
[11:33:31.824] Timer tick, asking Buildbucket for the build status
[11:33:31.988] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:31.988] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:24:0) after 1m0s
[11:34:32.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:24:0)
[11:34:32.089] Timer tick, asking Buildbucket for the build status
[11:34:32.376] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:32.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:25:0) after 1m0s
[11:35:32.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:25:0)
[11:35:32.458] Timer tick, asking Buildbucket for the build status
[11:35:32.946] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:32.946] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:26:0) after 1m0s
[11:36:33.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:26:0)
[11:36:33.056] Timer tick, asking Buildbucket for the build status
[11:36:33.618] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:33.618] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:27:0) after 1m0s
[11:37:33.671] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:27:0)
[11:37:33.671] Timer tick, asking Buildbucket for the build status
[11:37:33.868] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:33.868] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:28:0) after 1m0s
[11:38:34.055] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:28:0)
[11:38:34.055] Timer tick, asking Buildbucket for the build status
[11:38:34.449] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:34.449] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:29:0) after 1m0s
[11:39:34.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:29:0)
[11:39:34.520] Timer tick, asking Buildbucket for the build status
[11:39:35.981] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:35.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:30:0) after 1m0s
[11:40:36.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:30:0)
[11:40:36.063] Timer tick, asking Buildbucket for the build status
[11:40:36.826] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:36.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:31:0) after 1m0s
[11:41:36.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:31:0)
[11:41:36.930] Timer tick, asking Buildbucket for the build status
[11:41:37.140] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:37.140] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:32:0) after 1m0s
[11:42:37.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:32:0)
[11:42:37.162] Timer tick, asking Buildbucket for the build status
[11:42:37.860] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:37.860] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:33:0) after 1m0s
[11:43:37.970] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:33:0)
[11:43:37.970] Timer tick, asking Buildbucket for the build status
[11:43:38.147] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:38.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:34:0) after 1m0s
[11:44:38.173] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:34:0)
[11:44:38.173] Timer tick, asking Buildbucket for the build status
[11:44:38.415] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:38.415] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:35:0) after 1m0s
[11:45:38.446] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:35:0)
[11:45:38.446] Timer tick, asking Buildbucket for the build status
[11:45:40.634] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:40.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:36:0) after 1m0s
[11:46:40.688] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:36:0)
[11:46:40.688] Timer tick, asking Buildbucket for the build status
[11:46:41.055] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:41.055] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:37:0) after 1m0s
[11:47:41.084] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:37:0)
[11:47:41.084] Timer tick, asking Buildbucket for the build status
[11:47:41.560] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:41.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:38:0) after 1m0s
[11:48:41.581] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:38:0)
[11:48:41.581] Timer tick, asking Buildbucket for the build status
[11:48:42.155] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:42.155] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:39:0) after 1m0s
[11:49:42.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:39:0)
[11:49:42.202] Timer tick, asking Buildbucket for the build status
[11:49:42.473] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:42.473] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:40:0) after 1m0s
[11:50:43.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:40:0)
[11:50:43.043] Timer tick, asking Buildbucket for the build status
[11:50:43.233] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:43.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:41:0) after 1m0s
[11:51:43.423] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:41:0)
[11:51:43.423] Timer tick, asking Buildbucket for the build status
[11:51:43.653] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:43.653] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:42:0) after 1m0s
[11:52:44.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:42:0)
[11:52:44.192] Timer tick, asking Buildbucket for the build status
[11:52:44.400] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:44.401] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:43:0) after 1m0s
[11:53:44.603] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:43:0)
[11:53:44.603] Timer tick, asking Buildbucket for the build status
[11:53:45.372] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:45.372] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:44:0) after 1m0s
[11:54:45.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:44:0)
[11:54:45.391] Timer tick, asking Buildbucket for the build status
[11:54:46.003] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:46.003] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:45:0) after 1m0s
[11:55:46.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:45:0)
[11:55:46.015] Timer tick, asking Buildbucket for the build status
[11:55:46.283] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:46.283] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:46:0) after 1m0s
[11:56:46.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:46:0)
[11:56:46.411] Timer tick, asking Buildbucket for the build status
[11:56:49.647] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:49.647] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:47:0) after 1m0s
[11:57:49.778] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:47:0)
[11:57:49.778] Timer tick, asking Buildbucket for the build status
[11:57:50.015] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:50.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:48:0) after 1m0s
[11:58:50.268] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:48:0)
[11:58:50.268] Timer tick, asking Buildbucket for the build status
[11:58:50.442] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:50.442] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:49:0) after 1m0s
[11:59:50.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:49:0)
[11:59:50.770] Timer tick, asking Buildbucket for the build status
[11:59:53.928] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:53.928] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:50:0) after 1m0s
[12:00:54.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:50:0)
[12:00:54.912] Timer tick, asking Buildbucket for the build status
[12:00:55.197] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:55.197] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:51:0) after 1m0s
[12:01:55.410] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:51:0)
[12:01:55.410] Timer tick, asking Buildbucket for the build status
[12:01:56.198] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:56.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:52:0) after 1m0s
[12:02:56.393] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:52:0)
[12:02:56.394] Timer tick, asking Buildbucket for the build status
[12:02:56.670] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:56.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:53:0) after 1m0s
[12:03:57.076] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:53:0)
[12:03:57.076] Timer tick, asking Buildbucket for the build status
[12:03:57.265] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:57.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:54:0) after 1m0s
[12:04:57.814] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:54:0)
[12:04:57.814] Timer tick, asking Buildbucket for the build status
[12:04:58.096] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:58.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:55:0) after 1m0s
[12:05:58.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:55:0)
[12:05:58.365] Timer tick, asking Buildbucket for the build status
[12:05:58.561] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:58.562] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:56:0) after 1m0s
[12:06:58.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:56:0)
[12:06:58.816] Timer tick, asking Buildbucket for the build status
[12:06:59.461] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:59.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:57:0) after 1m0s
[12:07:59.542] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:57:0)
[12:07:59.542] Timer tick, asking Buildbucket for the build status
[12:08:00.044] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:00.044] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:58:0) after 1m0s
[12:09:00.123] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:58:0)
[12:09:00.123] Timer tick, asking Buildbucket for the build status
[12:09:00.360] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:00.360] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:59:0) after 1m0s
[12:10:00.399] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:59:0)
[12:10:00.399] Timer tick, asking Buildbucket for the build status
[12:10:01.382] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:01.382] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:60:0) after 1m0s
[12:11:01.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:60:0)
[12:11:01.407] Timer tick, asking Buildbucket for the build status
[12:11:01.600] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:01.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:61:0) after 1m0s
[12:12:01.858] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:61:0)
[12:12:01.858] Timer tick, asking Buildbucket for the build status
[12:12:02.238] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:02.238] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:62:0) after 1m0s
[12:13:02.274] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:62:0)
[12:13:02.274] Timer tick, asking Buildbucket for the build status
[12:13:02.591] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:02.591] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:63:0) after 1m0s
[12:14:02.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:63:0)
[12:14:02.804] Timer tick, asking Buildbucket for the build status
[12:14:03.571] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:03.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:64:0) after 1m0s
[12:15:03.670] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:64:0)
[12:15:03.670] Timer tick, asking Buildbucket for the build status
[12:15:03.822] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:03.822] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:65:0) after 1m0s
[12:16:03.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:65:0)
[12:16:03.873] Timer tick, asking Buildbucket for the build status
[12:16:04.178] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:04.178] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:66:0) after 1m0s
[12:17:04.273] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:66:0)
[12:17:04.273] Timer tick, asking Buildbucket for the build status
[12:17:06.336] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:06.337] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:67:0) after 1m0s
[12:18:06.366] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:67:0)
[12:18:06.366] Timer tick, asking Buildbucket for the build status
[12:18:08.327] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:08.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:68:0) after 1m0s
[12:19:08.494] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:68:0)
[12:19:08.495] Timer tick, asking Buildbucket for the build status
[12:19:08.725] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:08.725] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:69:0) after 1m0s
[12:20:08.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:69:0)
[12:20:08.741] Timer tick, asking Buildbucket for the build status
[12:20:08.911] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:08.911] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:70:0) after 1m0s
[12:21:08.911] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:70:0)
[12:21:08.911] Timer tick, asking Buildbucket for the build status
[12:21:09.522] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:09.522] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:71:0) after 1m0s
[12:22:09.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:71:0)
[12:22:09.557] Timer tick, asking Buildbucket for the build status
[12:22:09.715] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:09.715] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:72:0) after 1m0s
[12:23:09.800] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:72:0)
[12:23:09.800] Timer tick, asking Buildbucket for the build status
[12:23:10.028] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:10.028] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:73:0) after 1m0s
[12:24:10.046] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:73:0)
[12:24:10.046] Timer tick, asking Buildbucket for the build status
[12:24:10.346] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:10.347] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:74:0) after 1m0s
[12:25:10.384] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:74:0)
[12:25:10.384] Timer tick, asking Buildbucket for the build status
[12:25:10.839] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:10.839] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:75:0) after 1m0s
[12:26:10.936] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:75:0)
[12:26:10.936] Timer tick, asking Buildbucket for the build status
[12:26:11.882] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:11.883] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:76:0) after 1m0s
[12:27:12.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:76:0)
[12:27:12.001] Timer tick, asking Buildbucket for the build status
[12:27:13.308] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:13.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:77:0) after 1m0s
[12:28:13.586] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:77:0)
[12:28:13.586] Timer tick, asking Buildbucket for the build status
[12:28:13.818] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:13.818] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:78:0) after 1m0s
[12:29:13.873] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:78:0)
[12:29:13.873] Timer tick, asking Buildbucket for the build status
[12:29:14.033] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:14.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:79:0) after 1m0s
[12:30:14.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:79:0)
[12:30:14.117] Timer tick, asking Buildbucket for the build status
[12:30:15.363] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:15.363] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:80:0) after 1m0s
[12:31:15.444] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:80:0)
[12:31:15.444] Timer tick, asking Buildbucket for the build status
[12:31:16.166] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:16.166] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:81:0) after 1m0s
[12:32:16.244] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:81:0)
[12:32:16.244] Timer tick, asking Buildbucket for the build status
[12:32:16.533] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:16.533] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:82:0) after 1m0s
[12:33:16.751] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:82:0)
[12:33:16.751] Timer tick, asking Buildbucket for the build status
[12:33:17.020] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:17.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:83:0) after 1m0s
[12:34:17.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:83:0)
[12:34:17.037] Timer tick, asking Buildbucket for the build status
[12:34:17.181] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:17.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:84:0) after 1m0s
[12:35:17.232] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:84:0)
[12:35:17.232] Timer tick, asking Buildbucket for the build status
[12:35:17.469] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:17.469] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:85:0) after 1m0s
[12:36:17.497] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:85:0)
[12:36:17.497] Timer tick, asking Buildbucket for the build status
[12:36:17.642] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:17.642] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:86:0) after 1m0s
[12:37:17.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:86:0)
[12:37:17.676] Timer tick, asking Buildbucket for the build status
[12:37:18.620] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:18.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:87:0) after 1m0s
[12:38:18.735] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:87:0)
[12:38:18.735] Timer tick, asking Buildbucket for the build status
[12:38:19.076] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:88:0) after 1m0s
[12:39:19.342] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:88:0)
[12:39:19.342] Timer tick, asking Buildbucket for the build status
[12:39:19.582] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:19.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:89:0) after 1m0s
[12:40:19.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:89:0)
[12:40:19.631] Timer tick, asking Buildbucket for the build status
[12:40:20.531] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:20.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:90:0) after 1m0s
[12:41:20.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:90:0)
[12:41:20.557] Timer tick, asking Buildbucket for the build status
[12:41:21.087] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:21.087] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:91:0) after 1m0s
[12:42:21.156] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:91:0)
[12:42:21.156] Timer tick, asking Buildbucket for the build status
[12:42:23.204] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:23.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:92:0) after 1m0s
[12:43:23.177] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:92:0)
[12:43:23.177] Timer tick, asking Buildbucket for the build status
[12:43:23.552] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:23.552] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:93:0) after 1m0s
[12:44:23.611] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:93:0)
[12:44:23.611] Timer tick, asking Buildbucket for the build status
[12:44:24.143] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:24.143] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:94:0) after 1m0s
[12:45:24.213] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:94:0)
[12:45:24.213] Timer tick, asking Buildbucket for the build status
[12:45:24.368] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:24.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:95:0) after 1m0s
[12:46:24.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:95:0)
[12:46:24.407] Timer tick, asking Buildbucket for the build status
[12:46:24.599] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:24.599] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:96:0) after 1m0s
[12:47:24.631] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:96:0)
[12:47:24.631] Timer tick, asking Buildbucket for the build status
[12:47:25.088] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:25.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:97:0) after 1m0s
[12:48:25.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:97:0)
[12:48:25.131] Timer tick, asking Buildbucket for the build status
[12:48:25.335] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:25.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:98:0) after 1m0s
[12:49:25.404] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:98:0)
[12:49:25.404] Timer tick, asking Buildbucket for the build status
[12:49:26.057] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:26.057] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:99:0) after 1m0s
[12:50:26.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:99:0)
[12:50:26.129] Timer tick, asking Buildbucket for the build status
[12:50:26.603] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:26.603] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:100:0) after 1m0s
[12:51:26.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:100:0)
[12:51:26.695] Timer tick, asking Buildbucket for the build status
[12:51:26.889] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:26.889] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:101:0) after 1m0s
[12:52:26.912] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:101:0)
[12:52:26.912] Timer tick, asking Buildbucket for the build status
[12:52:27.073] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:27.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:102:0) after 1m0s
[12:53:27.117] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:102:0)
[12:53:27.117] Timer tick, asking Buildbucket for the build status
[12:53:28.326] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:28.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:103:0) after 1m0s
[12:54:28.398] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:103:0)
[12:54:28.398] Timer tick, asking Buildbucket for the build status
[12:54:28.564] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:28.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:104:0) after 1m0s
[12:55:28.676] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:104:0)
[12:55:28.676] Timer tick, asking Buildbucket for the build status
[12:55:28.844] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:28.844] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:105:0) after 1m0s
[12:56:28.906] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:105:0)
[12:56:28.906] Timer tick, asking Buildbucket for the build status
[12:56:29.228] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:106:0) after 1m0s
[12:57:29.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:106:0)
[12:57:29.261] Timer tick, asking Buildbucket for the build status
[12:57:29.747] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:29.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:107:0) after 1m0s
[12:58:29.843] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:107:0)
[12:58:29.843] Timer tick, asking Buildbucket for the build status
[12:58:30.009] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:30.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:108:0) after 1m0s
[12:59:30.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:108:0)
[12:59:30.044] Timer tick, asking Buildbucket for the build status
[12:59:30.713] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:30.713] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:109:0) after 1m0s
[13:00:30.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:109:0)
[13:00:30.850] Timer tick, asking Buildbucket for the build status
[13:00:31.015] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:31.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:110:0) after 1m0s
[13:01:31.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:110:0)
[13:01:31.074] Timer tick, asking Buildbucket for the build status
[13:01:31.223] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:31.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:111:0) after 1m0s
[13:02:31.378] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:111:0)
[13:02:31.378] Timer tick, asking Buildbucket for the build status
[13:02:32.308] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:32.308] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:112:0) after 1m0s
[13:03:32.309] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:112:0)
[13:03:32.309] Timer tick, asking Buildbucket for the build status
[13:03:32.875] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:32.875] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:113:0) after 1m0s
[13:04:32.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:113:0)
[13:04:32.925] Timer tick, asking Buildbucket for the build status
[13:04:33.167] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:33.167] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:114:0) after 1m0s
[13:05:33.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:114:0)
[13:05:33.195] Timer tick, asking Buildbucket for the build status
[13:05:33.896] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:33.896] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:115:0) after 1m0s
[13:06:33.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:115:0)
[13:06:33.920] Timer tick, asking Buildbucket for the build status
[13:06:34.288] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:34.288] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:116:0) after 1m0s
[13:07:34.486] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:116:0)
[13:07:34.486] Timer tick, asking Buildbucket for the build status
[13:07:34.837] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:34.837] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:117:0) after 1m0s
[13:08:34.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:117:0)
[13:08:34.889] Timer tick, asking Buildbucket for the build status
[13:08:35.426] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:35.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:118:0) after 1m0s
[13:09:35.505] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:118:0)
[13:09:35.505] Timer tick, asking Buildbucket for the build status
[13:09:35.702] Build 8903884836890627872: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:35.702] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9069314900368889648:119:0) after 1m0s
[13:09:55.886] Received PubSub notification, asking Buildbucket for the build status
[13:09:56.342] Build 8903884836890627872: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:09:56.342] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1566997795225224",
"created_by": "project:chromium",
"created_ts": "1566990737026875",
"id": "8903884836890627872",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e295b3f239f4273003d8c1b1e6446a61433fca78\"}}",
"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-32-14-4ddt\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 10512, \"got_angle_revision\": \"6f24d8a793886c85faf5f95353bdd4ff5975c2c0\", \"got_dawn_revision\": \"7ffd2346f8fad7d63091ea278d36e3f28177167b\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"e295b3f239f4273003d8c1b1e6446a61433fca78\", \"got_revision_cp\": \"refs/heads/master@{#691108}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"d190ff4eb6834bb09fb07be991337a862b2968e7\", \"got_v8_revision_cp\": \"refs/heads/7.8.207@{#1}\", \"got_webrtc_revision\": \"2d5aec56fdf7ff61166bb5fd3c67d4bcb81b0d5a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28975}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e295b3f239f4273003d8c1b1e6446a61433fca78\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-14-4ddt\"], \"image\": [\"chrome-xenial-19052201-9cb74617499\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1566990739935077",
"status": "COMPLETED",
"status_changed_ts": "1566997795578057",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/10512",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/e295b3f239f4273003d8c1b1e6446a61433fca78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e295b3f239f4273003d8c1b1e6446a61433fca78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069314900368889648",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903884836890627872/+/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:46f0bead8244f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1566997795586875",
"url": "https://ci.chromium.org/b/8903884836890627872",
"utcnow_ts": "1566997796318379"
}
}
[13:09:56.342] Invocation finished in 1h57m42.01700301s with status SUCCEEDED