[03:00:34.151] New invocation is queued and will start shortly
[03:00:35.278] Starting the invocation (attempt 1)
[03:00:35.319] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:00:35.319] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:00:35.319] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9062641658048284544",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"003a37b02847e77d9dab94003f44156a5ad289e5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9062641658048284544",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/003a37b02847e77d9dab94003f44156a5ad289e5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/003a37b02847e77d9dab94003f44156a5ad289e5",
"gitiles_ref:refs/heads/master"
]
}
[03:00:36.209] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1573354835582458",
"id": "8897211595883524016",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"003a37b02847e77d9dab94003f44156a5ad289e5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1573354836009505",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/12558",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/003a37b02847e77d9dab94003f44156a5ad289e5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/003a37b02847e77d9dab94003f44156a5ad289e5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062641658048284544",
"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/8897211595883524016/+/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": "1573354836009675",
"url": "https://ci.chromium.org/b/8897211595883524016",
"utcnow_ts": "1573354836185803"
}
}
[03:00:36.209] Task URL: https://ci.chromium.org/b/8897211595883524016
[03:00:36.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:2:0) after 1m0s
[03:01:45.224] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:2:0)
[03:01:45.224] Timer tick, asking Buildbucket for the build status
[03:01:45.643] Build 8897211595883524016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:01:45.643] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:3:0) after 1m0s
[03:02:45.647] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:3:0)
[03:02:45.647] Timer tick, asking Buildbucket for the build status
[03:02:45.921] Build 8897211595883524016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:02:45.921] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:4:0) after 1m0s
[03:03:46.074] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:4:0)
[03:03:46.074] Timer tick, asking Buildbucket for the build status
[03:03:46.621] Build 8897211595883524016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:03:46.621] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:5:0) after 1m0s
[03:04:46.663] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:5:0)
[03:04:46.663] Timer tick, asking Buildbucket for the build status
[03:04:47.232] Build 8897211595883524016: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[03:04:47.232] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:6:0) after 1m0s
[03:05:29.349] Received PubSub notification, asking Buildbucket for the build status
[03:05:30.229] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:47.253] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:6:0)
[03:05:47.253] Timer tick, asking Buildbucket for the build status
[03:05:48.149] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:48.149] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:8:0) after 1m0s
[03:06:48.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:8:0)
[03:06:48.172] Timer tick, asking Buildbucket for the build status
[03:06:48.376] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.376] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:9:0) after 1m0s
[03:07:48.407] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:9:0)
[03:07:48.407] Timer tick, asking Buildbucket for the build status
[03:07:48.641] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:10:0) after 1m0s
[03:08:48.753] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:10:0)
[03:08:48.753] Timer tick, asking Buildbucket for the build status
[03:08:49.423] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:49.423] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:11:0) after 1m0s
[03:09:49.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:11:0)
[03:09:49.539] Timer tick, asking Buildbucket for the build status
[03:09:49.748] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:49.748] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:12:0) after 1m0s
[03:10:49.794] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:12:0)
[03:10:49.795] Timer tick, asking Buildbucket for the build status
[03:10:50.600] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:50.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:13:0) after 1m0s
[03:11:50.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:13:0)
[03:11:50.715] Timer tick, asking Buildbucket for the build status
[03:11:53.531] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:53.531] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:14:0) after 1m0s
[03:12:53.551] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:14:0)
[03:12:53.552] Timer tick, asking Buildbucket for the build status
[03:12:57.327] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:57.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:15:0) after 1m0s
[03:13:57.385] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:15:0)
[03:13:57.385] Timer tick, asking Buildbucket for the build status
[03:13:57.706] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:57.706] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:16:0) after 1m0s
[03:14:57.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:16:0)
[03:14:57.729] Timer tick, asking Buildbucket for the build status
[03:14:58.016] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:58.016] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:17:0) after 1m0s
[03:15:58.040] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:17:0)
[03:15:58.040] Timer tick, asking Buildbucket for the build status
[03:15:58.331] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:58.331] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:18:0) after 1m0s
[03:16:58.360] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:18:0)
[03:16:58.360] Timer tick, asking Buildbucket for the build status
[03:16:58.641] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:58.641] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:19:0) after 1m0s
[03:17:58.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:19:0)
[03:17:58.695] Timer tick, asking Buildbucket for the build status
[03:17:59.540] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:59.540] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:20:0) after 1m0s
[03:18:59.702] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:20:0)
[03:18:59.702] Timer tick, asking Buildbucket for the build status
[03:19:03.536] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:03.536] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:21:0) after 1m0s
[03:20:03.548] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:21:0)
[03:20:03.548] Timer tick, asking Buildbucket for the build status
[03:20:03.737] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:03.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:22:0) after 1m0s
[03:21:03.762] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:22:0)
[03:21:03.762] Timer tick, asking Buildbucket for the build status
[03:21:04.381] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:04.381] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:23:0) after 1m0s
[03:22:04.456] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:23:0)
[03:22:04.456] Timer tick, asking Buildbucket for the build status
[03:22:04.843] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:04.843] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:24:0) after 1m0s
[03:23:04.909] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:24:0)
[03:23:04.909] Timer tick, asking Buildbucket for the build status
[03:23:05.334] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:05.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:25:0) after 1m0s
[03:24:05.437] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:25:0)
[03:24:05.437] Timer tick, asking Buildbucket for the build status
[03:24:05.620] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:05.620] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:26:0) after 1m0s
[03:25:05.668] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:26:0)
[03:25:05.668] Timer tick, asking Buildbucket for the build status
[03:25:06.772] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:06.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:27:0) after 1m0s
[03:26:06.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:27:0)
[03:26:06.802] Timer tick, asking Buildbucket for the build status
[03:26:06.974] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:06.974] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:28:0) after 1m0s
[03:27:06.981] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:28:0)
[03:27:06.981] Timer tick, asking Buildbucket for the build status
[03:27:07.187] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:07.187] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:29:0) after 1m0s
[03:28:07.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:29:0)
[03:28:07.218] Timer tick, asking Buildbucket for the build status
[03:28:07.539] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:07.539] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:30:0) after 1m0s
[03:29:07.576] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:30:0)
[03:29:07.576] Timer tick, asking Buildbucket for the build status
[03:29:10.788] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:10.788] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:31:0) after 1m0s
[03:30:10.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:31:0)
[03:30:10.954] Timer tick, asking Buildbucket for the build status
[03:30:11.362] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:32:0) after 1m0s
[03:31:11.462] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:32:0)
[03:31:11.462] Timer tick, asking Buildbucket for the build status
[03:31:11.772] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:11.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:33:0) after 1m0s
[03:32:15.278] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:33:0)
[03:32:15.278] Timer tick, asking Buildbucket for the build status
[03:32:15.483] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:15.483] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:34:0) after 1m0s
[03:33:15.557] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:34:0)
[03:33:15.557] Timer tick, asking Buildbucket for the build status
[03:33:16.274] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:16.274] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:35:0) after 1m0s
[03:34:16.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:35:0)
[03:34:16.375] Timer tick, asking Buildbucket for the build status
[03:34:17.670] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:36:0) after 1m0s
[03:35:17.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:36:0)
[03:35:17.755] Timer tick, asking Buildbucket for the build status
[03:35:18.112] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:18.112] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:37:0) after 1m0s
[03:36:18.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:37:0)
[03:36:18.195] Timer tick, asking Buildbucket for the build status
[03:36:18.579] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:18.579] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:38:0) after 1m0s
[03:37:18.566] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:38:0)
[03:37:18.566] Timer tick, asking Buildbucket for the build status
[03:37:19.495] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:19.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:39:0) after 1m0s
[03:38:19.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:39:0)
[03:38:19.622] Timer tick, asking Buildbucket for the build status
[03:38:20.600] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:20.600] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:40:0) after 1m0s
[03:39:20.622] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:40:0)
[03:39:20.622] Timer tick, asking Buildbucket for the build status
[03:39:21.223] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:21.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:41:0) after 1m0s
[03:40:21.346] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:41:0)
[03:40:21.346] Timer tick, asking Buildbucket for the build status
[03:40:22.317] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:22.317] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:42:0) after 1m0s
[03:41:23.125] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:42:0)
[03:41:23.125] Timer tick, asking Buildbucket for the build status
[03:41:23.350] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:23.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:43:0) after 1m0s
[03:42:23.600] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:43:0)
[03:42:23.600] Timer tick, asking Buildbucket for the build status
[03:42:23.826] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:23.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:44:0) after 1m0s
[03:43:24.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:44:0)
[03:43:24.063] Timer tick, asking Buildbucket for the build status
[03:43:26.116] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:26.116] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:45:0) after 1m0s
[03:44:27.888] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:45:0)
[03:44:27.888] Timer tick, asking Buildbucket for the build status
[03:44:28.208] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:46:0) after 1m0s
[03:45:28.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:46:0)
[03:45:28.476] Timer tick, asking Buildbucket for the build status
[03:45:28.675] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:28.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:47:0) after 1m0s
[03:46:28.712] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:47:0)
[03:46:28.712] Timer tick, asking Buildbucket for the build status
[03:46:30.184] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:30.184] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:48:0) after 1m0s
[03:47:30.413] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:48:0)
[03:47:30.413] Timer tick, asking Buildbucket for the build status
[03:47:31.158] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:31.158] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:49:0) after 1m0s
[03:48:31.259] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:49:0)
[03:48:31.259] Timer tick, asking Buildbucket for the build status
[03:48:32.123] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:32.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:50:0) after 1m0s
[03:49:32.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:50:0)
[03:49:32.326] Timer tick, asking Buildbucket for the build status
[03:49:33.553] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:33.553] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:51:0) after 1m0s
[03:50:33.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:51:0)
[03:50:33.769] Timer tick, asking Buildbucket for the build status
[03:50:33.948] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:33.948] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:52:0) after 1m0s
[03:51:34.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:52:0)
[03:51:34.056] Timer tick, asking Buildbucket for the build status
[03:51:34.633] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:34.633] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:53:0) after 1m0s
[03:52:34.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:53:0)
[03:52:34.852] Timer tick, asking Buildbucket for the build status
[03:52:35.262] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:35.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:54:0) after 1m0s
[03:53:35.350] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:54:0)
[03:53:35.350] Timer tick, asking Buildbucket for the build status
[03:53:35.548] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:35.548] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:55:0) after 1m0s
[03:54:35.715] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:55:0)
[03:54:35.715] Timer tick, asking Buildbucket for the build status
[03:54:36.042] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:36.042] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:56:0) after 1m0s
[03:55:36.131] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:56:0)
[03:55:36.131] Timer tick, asking Buildbucket for the build status
[03:55:36.327] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:36.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:57:0) after 1m0s
[03:56:36.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:57:0)
[03:56:36.445] Timer tick, asking Buildbucket for the build status
[03:56:36.607] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:36.607] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:58:0) after 1m0s
[03:57:36.713] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:58:0)
[03:57:36.713] Timer tick, asking Buildbucket for the build status
[03:57:36.971] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:36.971] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:59:0) after 1m0s
[03:58:37.049] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:59:0)
[03:58:37.049] Timer tick, asking Buildbucket for the build status
[03:58:38.097] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:38.097] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:60:0) after 1m0s
[03:59:38.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:60:0)
[03:59:38.087] Timer tick, asking Buildbucket for the build status
[03:59:38.252] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:38.252] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:61:0) after 1m0s
[04:00:38.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:61:0)
[04:00:38.281] Timer tick, asking Buildbucket for the build status
[04:00:38.934] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:38.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:62:0) after 1m0s
[04:01:39.037] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:62:0)
[04:01:39.037] Timer tick, asking Buildbucket for the build status
[04:01:39.280] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:39.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:63:0) after 1m0s
[04:02:39.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:63:0)
[04:02:39.294] Timer tick, asking Buildbucket for the build status
[04:02:39.516] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:39.516] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:64:0) after 1m0s
[04:03:39.638] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:64:0)
[04:03:39.638] Timer tick, asking Buildbucket for the build status
[04:03:40.610] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:40.610] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:65:0) after 1m0s
[04:04:40.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:65:0)
[04:04:40.700] Timer tick, asking Buildbucket for the build status
[04:04:44.855] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:44.855] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:66:0) after 1m0s
[04:05:45.086] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:66:0)
[04:05:45.086] Timer tick, asking Buildbucket for the build status
[04:05:45.614] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:45.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:67:0) after 1m0s
[04:06:45.642] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:67:0)
[04:06:45.642] Timer tick, asking Buildbucket for the build status
[04:06:45.932] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:45.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:68:0) after 1m0s
[04:07:45.954] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:68:0)
[04:07:45.954] Timer tick, asking Buildbucket for the build status
[04:07:47.341] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:47.341] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:69:0) after 1m0s
[04:08:47.424] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:69:0)
[04:08:47.424] Timer tick, asking Buildbucket for the build status
[04:08:47.613] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:47.613] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:70:0) after 1m0s
[04:09:47.656] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:70:0)
[04:09:47.656] Timer tick, asking Buildbucket for the build status
[04:09:47.835] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:47.835] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:71:0) after 1m0s
[04:10:47.861] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:71:0)
[04:10:47.861] Timer tick, asking Buildbucket for the build status
[04:10:48.327] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:48.327] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:72:0) after 1m0s
[04:11:48.351] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:72:0)
[04:11:48.351] Timer tick, asking Buildbucket for the build status
[04:11:48.564] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:48.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:73:0) after 1m0s
[04:12:54.280] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:73:0)
[04:12:54.280] Timer tick, asking Buildbucket for the build status
[04:12:54.749] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:54.749] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:74:0) after 1m0s
[04:13:55.026] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:74:0)
[04:13:55.026] Timer tick, asking Buildbucket for the build status
[04:13:55.810] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:55.810] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:75:0) after 1m0s
[04:14:55.839] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:75:0)
[04:14:55.839] Timer tick, asking Buildbucket for the build status
[04:14:56.064] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:56.064] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:76:0) after 1m0s
[04:15:56.162] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:76:0)
[04:15:56.162] Timer tick, asking Buildbucket for the build status
[04:15:56.462] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:56.462] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:77:0) after 1m0s
[04:16:56.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:77:0)
[04:16:56.592] Timer tick, asking Buildbucket for the build status
[04:16:57.296] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:57.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:78:0) after 1m0s
[04:17:57.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:78:0)
[04:17:57.286] Timer tick, asking Buildbucket for the build status
[04:17:57.495] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:57.495] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:79:0) after 1m0s
[04:18:57.608] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:79:0)
[04:18:57.608] Timer tick, asking Buildbucket for the build status
[04:18:59.223] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.223] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:80:0) after 1m0s
[04:19:59.502] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:80:0)
[04:19:59.502] Timer tick, asking Buildbucket for the build status
[04:19:59.913] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:59.913] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:81:0) after 1m0s
[04:20:59.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:81:0)
[04:20:59.989] Timer tick, asking Buildbucket for the build status
[04:21:00.804] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:00.804] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:82:0) after 1m0s
[04:22:00.808] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:82:0)
[04:22:00.808] Timer tick, asking Buildbucket for the build status
[04:22:00.997] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:00.997] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:83:0) after 1m0s
[04:23:01.094] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:83:0)
[04:23:01.094] Timer tick, asking Buildbucket for the build status
[04:23:01.311] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:01.311] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:84:0) after 1m0s
[04:24:01.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:84:0)
[04:24:01.445] Timer tick, asking Buildbucket for the build status
[04:24:02.021] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:02.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:85:0) after 1m0s
[04:25:02.048] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:85:0)
[04:25:02.048] Timer tick, asking Buildbucket for the build status
[04:25:02.877] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:02.877] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:86:0) after 1m0s
[04:26:02.972] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:86:0)
[04:26:02.972] Timer tick, asking Buildbucket for the build status
[04:26:03.369] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:03.369] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:87:0) after 1m0s
[04:27:03.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:87:0)
[04:27:03.459] Timer tick, asking Buildbucket for the build status
[04:27:04.133] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:04.133] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:88:0) after 1m0s
[04:28:04.262] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:88:0)
[04:28:04.262] Timer tick, asking Buildbucket for the build status
[04:28:04.514] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:04.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:89:0) after 1m0s
[04:29:04.543] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:89:0)
[04:29:04.543] Timer tick, asking Buildbucket for the build status
[04:29:05.009] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:05.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:90:0) after 1m0s
[04:30:05.114] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:90:0)
[04:30:05.114] Timer tick, asking Buildbucket for the build status
[04:30:05.323] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:05.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:91:0) after 1m0s
[04:31:05.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:91:0)
[04:31:05.364] Timer tick, asking Buildbucket for the build status
[04:31:06.835] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:06.836] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:92:0) after 1m0s
[04:32:06.880] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:92:0)
[04:32:06.880] Timer tick, asking Buildbucket for the build status
[04:32:07.126] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:07.126] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:93:0) after 1m0s
[04:33:07.119] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:93:0)
[04:33:07.119] Timer tick, asking Buildbucket for the build status
[04:33:07.350] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:07.350] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:94:0) after 1m0s
[04:34:07.343] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:94:0)
[04:34:07.343] Timer tick, asking Buildbucket for the build status
[04:34:07.793] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:07.793] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:95:0) after 1m0s
[04:35:07.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:95:0)
[04:35:07.850] Timer tick, asking Buildbucket for the build status
[04:35:08.245] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:08.245] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:96:0) after 1m0s
[04:36:08.307] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:96:0)
[04:36:08.307] Timer tick, asking Buildbucket for the build status
[04:36:08.485] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:08.485] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:97:0) after 1m0s
[04:37:08.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:97:0)
[04:37:08.607] Timer tick, asking Buildbucket for the build status
[04:37:09.932] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:09.932] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:98:0) after 1m0s
[04:38:10.195] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:98:0)
[04:38:10.195] Timer tick, asking Buildbucket for the build status
[04:38:11.716] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:11.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:99:0) after 1m0s
[04:39:12.324] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:99:0)
[04:39:12.324] Timer tick, asking Buildbucket for the build status
[04:39:13.106] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:13.106] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:100:0) after 1m0s
[04:40:13.361] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:100:0)
[04:40:13.361] Timer tick, asking Buildbucket for the build status
[04:40:13.595] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:13.595] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:101:0) after 1m0s
[04:41:13.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:101:0)
[04:41:13.661] Timer tick, asking Buildbucket for the build status
[04:41:13.826] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:13.826] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:102:0) after 1m0s
[04:42:14.015] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:102:0)
[04:42:14.015] Timer tick, asking Buildbucket for the build status
[04:42:14.262] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:14.262] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:103:0) after 1m0s
[04:43:14.321] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:103:0)
[04:43:14.321] Timer tick, asking Buildbucket for the build status
[04:43:14.541] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:14.541] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:104:0) after 1m0s
[04:44:14.592] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:104:0)
[04:44:14.593] Timer tick, asking Buildbucket for the build status
[04:44:16.466] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:16.466] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:105:0) after 1m0s
[04:45:16.607] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:105:0)
[04:45:16.607] Timer tick, asking Buildbucket for the build status
[04:45:16.751] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:16.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:106:0) after 1m0s
[04:46:16.850] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:106:0)
[04:46:16.850] Timer tick, asking Buildbucket for the build status
[04:46:17.093] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:17.093] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:107:0) after 1m0s
[04:47:17.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:107:0)
[04:47:17.391] Timer tick, asking Buildbucket for the build status
[04:47:17.575] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:17.575] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:108:0) after 1m0s
[04:48:17.757] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:108:0)
[04:48:17.757] Timer tick, asking Buildbucket for the build status
[04:48:18.802] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:18.802] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:109:0) after 1m0s
[04:49:19.180] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:109:0)
[04:49:19.180] Timer tick, asking Buildbucket for the build status
[04:49:19.370] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:19.370] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:110:0) after 1m0s
[04:50:19.599] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:110:0)
[04:50:19.599] Timer tick, asking Buildbucket for the build status
[04:50:19.785] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:19.785] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:111:0) after 1m0s
[04:51:19.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:111:0)
[04:51:19.813] Timer tick, asking Buildbucket for the build status
[04:51:20.067] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:20.067] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:112:0) after 1m0s
[04:52:20.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:112:0)
[04:52:20.729] Timer tick, asking Buildbucket for the build status
[04:52:20.900] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:20.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:113:0) after 1m0s
[04:53:21.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:113:0)
[04:53:21.137] Timer tick, asking Buildbucket for the build status
[04:53:21.333] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:21.333] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:114:0) after 1m0s
[04:54:21.695] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:114:0)
[04:54:21.695] Timer tick, asking Buildbucket for the build status
[04:54:22.819] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:22.819] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:115:0) after 1m0s
[04:55:23.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:115:0)
[04:55:23.034] Timer tick, asking Buildbucket for the build status
[04:55:23.509] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:23.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:116:0) after 1m0s
[04:56:23.539] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:116:0)
[04:56:23.539] Timer tick, asking Buildbucket for the build status
[04:56:23.716] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:23.716] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:117:0) after 1m0s
[04:57:23.892] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:117:0)
[04:57:23.892] Timer tick, asking Buildbucket for the build status
[04:57:24.738] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:24.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:118:0) after 1m0s
[04:58:25.269] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:118:0)
[04:58:25.269] Timer tick, asking Buildbucket for the build status
[04:58:25.697] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:25.697] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:119:0) after 1m0s
[04:59:25.920] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:119:0)
[04:59:25.920] Timer tick, asking Buildbucket for the build status
[04:59:26.063] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:26.063] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:120:0) after 1m0s
[05:00:26.475] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:120:0)
[05:00:26.475] Timer tick, asking Buildbucket for the build status
[05:00:26.686] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:26.686] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:121:0) after 1m0s
[05:01:26.714] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:121:0)
[05:01:26.714] Timer tick, asking Buildbucket for the build status
[05:01:27.428] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:27.428] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:122:0) after 1m0s
[05:02:27.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:122:0)
[05:02:27.477] Timer tick, asking Buildbucket for the build status
[05:02:27.680] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:27.680] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:123:0) after 1m0s
[05:03:27.716] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:123:0)
[05:03:27.716] Timer tick, asking Buildbucket for the build status
[05:03:29.192] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:29.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:124:0) after 1m0s
[05:04:29.183] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:124:0)
[05:04:29.184] Timer tick, asking Buildbucket for the build status
[05:04:29.462] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:29.462] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:125:0) after 1m0s
[05:05:29.569] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:125:0)
[05:05:29.569] Timer tick, asking Buildbucket for the build status
[05:05:30.053] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:126:0) after 1m0s
[05:06:30.604] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:126:0)
[05:06:30.604] Timer tick, asking Buildbucket for the build status
[05:06:31.277] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:31.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:127:0) after 1m0s
[05:07:31.680] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:127:0)
[05:07:31.680] Timer tick, asking Buildbucket for the build status
[05:07:32.561] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:32.561] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:128:0) after 1m0s
[05:08:32.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:128:0)
[05:08:32.925] Timer tick, asking Buildbucket for the build status
[05:08:33.184] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:33.184] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:129:0) after 1m0s
[05:09:33.326] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:129:0)
[05:09:33.327] Timer tick, asking Buildbucket for the build status
[05:09:34.634] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:34.634] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:130:0) after 1m0s
[05:10:35.063] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:130:0)
[05:10:35.063] Timer tick, asking Buildbucket for the build status
[05:10:36.014] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:36.014] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:131:0) after 1m0s
[05:11:36.265] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:131:0)
[05:11:36.265] Timer tick, asking Buildbucket for the build status
[05:11:36.493] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:36.493] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:132:0) after 1m0s
[05:12:37.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:132:0)
[05:12:37.103] Timer tick, asking Buildbucket for the build status
[05:12:37.296] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:37.296] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:133:0) after 1m0s
[05:13:37.480] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:133:0)
[05:13:37.480] Timer tick, asking Buildbucket for the build status
[05:13:37.772] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:37.772] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:134:0) after 1m0s
[05:14:37.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:134:0)
[05:14:37.950] Timer tick, asking Buildbucket for the build status
[05:14:38.926] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.926] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:135:0) after 1m0s
[05:15:39.090] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:135:0)
[05:15:39.090] Timer tick, asking Buildbucket for the build status
[05:15:39.373] Build 8897211595883524016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:39.373] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9062641658048284544:136:0) after 1m0s
[05:16:38.963] Received PubSub notification, asking Buildbucket for the build status
[05:16:39.113] Build 8897211595883524016: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:16:39.113] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1573362997741340",
"created_by": "project:chromium",
"created_ts": "1573354835582458",
"id": "8897211595883524016",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"003a37b02847e77d9dab94003f44156a5ad289e5\"}}",
"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-1-tp0u\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 12558, \"got_angle_revision\": \"012d15196023467be913ef6d537417be91e68e16\", \"got_dawn_revision\": \"600a26d50a04d82cade2f52c79a2d7ad9e71b89b\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"003a37b02847e77d9dab94003f44156a5ad289e5\", \"got_revision_cp\": \"refs/heads/master@{#714112}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"31edef751a8d8428db1fc9e0f68c345ab987811f\", \"got_v8_revision\": \"70bbd167b9c638b49d5eee7bd26a84ce4e481601\", \"got_v8_revision_cp\": \"refs/heads/8.0.213@{#1}\", \"got_webrtc_revision\": \"a4c1aaad8d5fe0d412f08f084b0aa36e01393550\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29750}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"003a37b02847e77d9dab94003f44156a5ad289e5\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-32-1-tp0u\"], \"image\": [\"chrome-xenial-19102400-d35fedf5a0d\"], \"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\": [\"4621-f8a5b1c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1573355126578527",
"status": "COMPLETED",
"status_changed_ts": "1573362998326228",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/12558",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/003a37b02847e77d9dab94003f44156a5ad289e5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/003a37b02847e77d9dab94003f44156a5ad289e5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9062641658048284544",
"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/8897211595883524016/+/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:486c1319d25cdc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1573362998393252",
"url": "https://ci.chromium.org/b/8897211595883524016",
"utcnow_ts": "1573362999105163"
}
}
[05:16:39.113] Invocation finished in 2h16m4.980409479s with status SUCCEEDED