[05:59:59.135] New invocation is queued and will start shortly
[06:00:00.227] Starting the invocation (attempt 1)
[06:00:00.357] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:00:00.357] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:00:00.357] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061090221720031808",
"parameters_json": "{\"builder_name\":\"Deterministic Linux\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"49e538770e303bea75e1d07cf913badc429e5e0b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux",
"scheduler_invocation_id:9061090221720031808",
"scheduler_job_id:chromium/Deterministic Linux",
"user_agent:luci-scheduler",
"buildset:commit/git/49e538770e303bea75e1d07cf913badc429e5e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e538770e303bea75e1d07cf913badc429e5e0b",
"gitiles_ref:refs/heads/master"
]
}
[06:00:02.221] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574834400805154",
"id": "8895660159300110480",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49e538770e303bea75e1d07cf913badc429e5e0b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574834401826919",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25853",
"builder:Deterministic Linux",
"buildset:commit/git/49e538770e303bea75e1d07cf913badc429e5e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e538770e303bea75e1d07cf913badc429e5e0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061090221720031808",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8895660159300110480/+/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": "1574834401827031",
"url": "https://ci.chromium.org/b/8895660159300110480",
"utcnow_ts": "1574834402212818"
}
}
[06:00:02.221] Task URL: https://ci.chromium.org/b/8895660159300110480
[06:00:02.221] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:2:0) after 1m0s
[06:00:05.095] Received PubSub notification, asking Buildbucket for the build status
[06:00:05.284] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:02.365] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:2:0)
[06:01:02.365] Timer tick, asking Buildbucket for the build status
[06:01:04.808] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:04.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:4:0) after 1m0s
[06:02:04.869] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:4:0)
[06:02:04.869] Timer tick, asking Buildbucket for the build status
[06:02:05.973] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:05.973] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:5:0) after 1m0s
[06:03:06.035] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:5:0)
[06:03:06.035] Timer tick, asking Buildbucket for the build status
[06:03:06.339] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:06.339] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:6:0) after 1m0s
[06:04:06.389] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:6:0)
[06:04:06.389] Timer tick, asking Buildbucket for the build status
[06:04:06.605] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:06.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:7:0) after 1m0s
[06:05:06.745] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:7:0)
[06:05:06.745] Timer tick, asking Buildbucket for the build status
[06:05:07.942] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:07.942] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:8:0) after 1m0s
[06:06:08.044] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:8:0)
[06:06:08.044] Timer tick, asking Buildbucket for the build status
[06:06:10.017] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:10.017] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:9:0) after 1m0s
[06:07:10.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:9:0)
[06:07:10.104] Timer tick, asking Buildbucket for the build status
[06:07:11.096] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:11.096] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:10:0) after 1m0s
[06:08:11.127] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:10:0)
[06:08:11.127] Timer tick, asking Buildbucket for the build status
[06:08:12.073] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:12.073] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:11:0) after 1m0s
[06:09:12.103] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:11:0)
[06:09:12.103] Timer tick, asking Buildbucket for the build status
[06:09:12.543] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:12:0) after 1m0s
[06:10:12.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:12:0)
[06:10:12.625] Timer tick, asking Buildbucket for the build status
[06:10:12.864] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:12.864] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:13:0) after 1m0s
[06:11:12.930] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:13:0)
[06:11:12.931] Timer tick, asking Buildbucket for the build status
[06:11:13.189] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:13.189] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:14:0) after 1m0s
[06:12:13.218] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:14:0)
[06:12:13.218] Timer tick, asking Buildbucket for the build status
[06:12:14.118] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:14.119] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:15:0) after 1m0s
[06:13:14.203] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:15:0)
[06:13:14.203] Timer tick, asking Buildbucket for the build status
[06:13:14.392] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:14.392] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:16:0) after 1m0s
[06:14:14.395] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:16:0)
[06:14:14.395] Timer tick, asking Buildbucket for the build status
[06:14:14.608] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:14.608] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:17:0) after 1m0s
[06:15:14.664] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:17:0)
[06:15:14.664] Timer tick, asking Buildbucket for the build status
[06:15:14.808] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:14.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:18:0) after 1m0s
[06:16:14.801] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:18:0)
[06:16:14.801] Timer tick, asking Buildbucket for the build status
[06:16:15.169] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:15.169] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:19:0) after 1m0s
[06:17:15.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:19:0)
[06:17:15.228] Timer tick, asking Buildbucket for the build status
[06:17:16.235] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:16.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:20:0) after 1m0s
[06:18:16.391] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:20:0)
[06:18:16.391] Timer tick, asking Buildbucket for the build status
[06:18:16.567] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:16.567] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:21:0) after 1m0s
[06:19:16.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:21:0)
[06:19:16.661] Timer tick, asking Buildbucket for the build status
[06:19:16.936] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:22:0) after 1m0s
[06:20:17.056] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:22:0)
[06:20:17.056] Timer tick, asking Buildbucket for the build status
[06:20:17.315] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:17.315] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:23:0) after 1m0s
[06:21:17.364] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:23:0)
[06:21:17.364] Timer tick, asking Buildbucket for the build status
[06:21:17.542] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:17.542] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:24:0) after 1m0s
[06:22:17.598] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:24:0)
[06:22:17.598] Timer tick, asking Buildbucket for the build status
[06:22:17.891] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:17.892] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:25:0) after 1m0s
[06:23:17.914] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:25:0)
[06:23:17.914] Timer tick, asking Buildbucket for the build status
[06:23:18.233] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:18.233] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:26:0) after 1m0s
[06:24:18.277] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:26:0)
[06:24:18.277] Timer tick, asking Buildbucket for the build status
[06:24:18.565] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:18.565] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:27:0) after 1m0s
[06:25:18.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:27:0)
[06:25:18.556] Timer tick, asking Buildbucket for the build status
[06:25:18.815] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:18.815] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:28:0) after 1m0s
[06:26:18.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:28:0)
[06:26:18.889] Timer tick, asking Buildbucket for the build status
[06:26:19.118] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:19.118] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:29:0) after 1m0s
[06:27:19.184] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:29:0)
[06:27:19.184] Timer tick, asking Buildbucket for the build status
[06:27:19.492] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:19.492] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:30:0) after 1m0s
[06:28:19.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:30:0)
[06:28:19.517] Timer tick, asking Buildbucket for the build status
[06:28:19.721] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:19.721] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:31:0) after 1m0s
[06:29:19.946] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:31:0)
[06:29:19.946] Timer tick, asking Buildbucket for the build status
[06:29:20.131] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:20.131] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:32:0) after 1m0s
[06:30:20.217] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:32:0)
[06:30:20.218] Timer tick, asking Buildbucket for the build status
[06:30:20.494] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:20.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:33:0) after 1m0s
[06:31:20.524] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:33:0)
[06:31:20.524] Timer tick, asking Buildbucket for the build status
[06:31:21.334] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:21.334] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:34:0) after 1m0s
[06:32:21.375] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:34:0)
[06:32:21.375] Timer tick, asking Buildbucket for the build status
[06:32:22.799] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:22.799] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:35:0) after 1m0s
[06:33:22.827] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:35:0)
[06:33:22.827] Timer tick, asking Buildbucket for the build status
[06:33:23.271] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:23.271] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:36:0) after 1m0s
[06:34:23.347] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:36:0)
[06:34:23.347] Timer tick, asking Buildbucket for the build status
[06:34:23.623] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:23.623] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:37:0) after 1m0s
[06:35:23.662] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:37:0)
[06:35:23.662] Timer tick, asking Buildbucket for the build status
[06:35:24.076] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:24.076] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:38:0) after 1m0s
[06:36:24.104] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:38:0)
[06:36:24.104] Timer tick, asking Buildbucket for the build status
[06:36:24.284] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:24.284] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:39:0) after 1m0s
[06:37:24.264] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:39:0)
[06:37:24.264] Timer tick, asking Buildbucket for the build status
[06:37:25.560] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:25.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:40:0) after 1m0s
[06:38:25.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:40:0)
[06:38:25.583] Timer tick, asking Buildbucket for the build status
[06:38:25.906] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:25.906] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:41:0) after 1m0s
[06:39:26.000] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:41:0)
[06:39:26.000] Timer tick, asking Buildbucket for the build status
[06:39:28.683] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:28.683] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:42:0) after 1m0s
[06:40:28.700] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:42:0)
[06:40:28.700] Timer tick, asking Buildbucket for the build status
[06:40:28.936] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:28.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:43:0) after 1m0s
[06:41:29.009] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:43:0)
[06:41:29.009] Timer tick, asking Buildbucket for the build status
[06:41:29.217] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:29.217] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:44:0) after 1m0s
[06:42:29.312] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:44:0)
[06:42:29.312] Timer tick, asking Buildbucket for the build status
[06:42:30.075] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:30.075] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:45:0) after 1m0s
[06:43:30.108] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:45:0)
[06:43:30.108] Timer tick, asking Buildbucket for the build status
[06:43:30.259] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:30.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:46:0) after 1m0s
[06:44:30.281] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:46:0)
[06:44:30.281] Timer tick, asking Buildbucket for the build status
[06:44:30.730] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:30.730] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:47:0) after 1m0s
[06:45:30.766] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:47:0)
[06:45:30.767] Timer tick, asking Buildbucket for the build status
[06:45:31.571] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:31.571] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:48:0) after 1m0s
[06:46:31.629] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:48:0)
[06:46:31.629] Timer tick, asking Buildbucket for the build status
[06:46:32.005] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:32.005] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:49:0) after 1m0s
[06:47:32.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:49:0)
[06:47:32.113] Timer tick, asking Buildbucket for the build status
[06:47:32.326] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:32.326] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:50:0) after 1m0s
[06:48:32.512] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:50:0)
[06:48:32.512] Timer tick, asking Buildbucket for the build status
[06:48:33.015] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:33.015] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:51:0) after 1m0s
[06:49:33.052] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:51:0)
[06:49:33.052] Timer tick, asking Buildbucket for the build status
[06:49:33.265] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:33.265] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:52:0) after 1m0s
[06:50:33.297] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:52:0)
[06:50:33.298] Timer tick, asking Buildbucket for the build status
[06:50:34.421] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:34.421] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:53:0) after 1m0s
[06:51:34.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:53:0)
[06:51:34.500] Timer tick, asking Buildbucket for the build status
[06:51:34.998] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:34.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:54:0) after 1m0s
[06:52:35.053] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:54:0)
[06:52:35.053] Timer tick, asking Buildbucket for the build status
[06:52:35.560] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:55:0) after 1m0s
[06:53:35.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:55:0)
[06:53:35.602] Timer tick, asking Buildbucket for the build status
[06:53:35.768] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:35.768] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:56:0) after 1m0s
[06:54:35.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:56:0)
[06:54:35.806] Timer tick, asking Buildbucket for the build status
[06:54:36.058] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:36.058] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:57:0) after 1m0s
[06:55:36.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:57:0)
[06:55:36.112] Timer tick, asking Buildbucket for the build status
[06:55:36.630] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:36.630] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:58:0) after 1m0s
[06:56:36.654] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:58:0)
[06:56:36.654] Timer tick, asking Buildbucket for the build status
[06:56:37.083] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:37.083] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:59:0) after 1m0s
[06:57:37.215] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:59:0)
[06:57:37.215] Timer tick, asking Buildbucket for the build status
[06:57:37.509] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:60:0) after 1m0s
[06:58:37.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:60:0)
[06:58:37.602] Timer tick, asking Buildbucket for the build status
[06:58:38.179] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:38.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:61:0) after 1m0s
[06:59:38.286] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:61:0)
[06:59:38.286] Timer tick, asking Buildbucket for the build status
[06:59:38.614] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:38.614] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:62:0) after 1m0s
[07:00:38.648] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:62:0)
[07:00:38.648] Timer tick, asking Buildbucket for the build status
[07:00:38.868] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:38.869] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:63:0) after 1m0s
[07:01:38.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:63:0)
[07:01:38.932] Timer tick, asking Buildbucket for the build status
[07:01:39.179] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:39.179] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:64:0) after 1m0s
[07:02:39.220] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:64:0)
[07:02:39.220] Timer tick, asking Buildbucket for the build status
[07:02:39.589] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:39.589] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:65:0) after 1m0s
[07:03:39.613] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:65:0)
[07:03:39.613] Timer tick, asking Buildbucket for the build status
[07:03:41.512] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:41.512] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:66:0) after 1m0s
[07:04:41.722] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:66:0)
[07:04:41.722] Timer tick, asking Buildbucket for the build status
[07:04:42.437] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:42.437] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:67:0) after 1m0s
[07:05:42.500] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:67:0)
[07:05:42.500] Timer tick, asking Buildbucket for the build status
[07:05:42.858] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:42.858] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:68:0) after 1m0s
[07:06:42.950] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:68:0)
[07:06:42.951] Timer tick, asking Buildbucket for the build status
[07:06:43.180] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:43.181] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:69:0) after 1m0s
[07:07:43.208] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:69:0)
[07:07:43.208] Timer tick, asking Buildbucket for the build status
[07:07:44.020] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:44.020] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:70:0) after 1m0s
[07:08:44.172] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:70:0)
[07:08:44.172] Timer tick, asking Buildbucket for the build status
[07:08:44.332] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:44.332] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:71:0) after 1m0s
[07:09:44.443] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:71:0)
[07:09:44.443] Timer tick, asking Buildbucket for the build status
[07:09:44.660] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:44.660] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:72:0) after 1m0s
[07:10:44.726] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:72:0)
[07:10:44.726] Timer tick, asking Buildbucket for the build status
[07:10:44.992] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:44.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:73:0) after 1m0s
[07:11:45.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:73:0)
[07:11:45.107] Timer tick, asking Buildbucket for the build status
[07:11:45.335] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:45.335] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:74:0) after 1m0s
[07:12:45.445] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:74:0)
[07:12:45.445] Timer tick, asking Buildbucket for the build status
[07:12:46.198] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:46.198] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:75:0) after 1m0s
[07:13:46.296] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:75:0)
[07:13:46.296] Timer tick, asking Buildbucket for the build status
[07:13:46.459] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:46.459] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:76:0) after 1m0s
[07:14:46.556] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:76:0)
[07:14:46.556] Timer tick, asking Buildbucket for the build status
[07:14:46.776] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:46.776] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:77:0) after 1m0s
[07:15:46.855] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:77:0)
[07:15:46.855] Timer tick, asking Buildbucket for the build status
[07:15:47.307] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:47.307] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:78:0) after 1m0s
[07:16:47.458] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:78:0)
[07:16:47.458] Timer tick, asking Buildbucket for the build status
[07:16:47.708] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:47.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:79:0) after 1m0s
[07:17:47.732] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:79:0)
[07:17:47.732] Timer tick, asking Buildbucket for the build status
[07:17:47.920] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:47.920] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:80:0) after 1m0s
[07:18:47.958] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:80:0)
[07:18:47.958] Timer tick, asking Buildbucket for the build status
[07:18:49.056] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:49.056] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:81:0) after 1m0s
[07:19:49.070] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:81:0)
[07:19:49.070] Timer tick, asking Buildbucket for the build status
[07:19:49.585] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:49.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:82:0) after 1m0s
[07:20:49.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:82:0)
[07:20:49.641] Timer tick, asking Buildbucket for the build status
[07:20:50.125] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:50.125] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:83:0) after 1m0s
[07:21:50.165] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:83:0)
[07:21:50.165] Timer tick, asking Buildbucket for the build status
[07:21:50.386] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:50.386] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:84:0) after 1m0s
[07:22:50.425] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:84:0)
[07:22:50.425] Timer tick, asking Buildbucket for the build status
[07:22:51.088] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:51.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:85:0) after 1m0s
[07:23:51.129] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:85:0)
[07:23:51.129] Timer tick, asking Buildbucket for the build status
[07:23:51.441] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:51.441] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:86:0) after 1m0s
[07:24:51.495] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:86:0)
[07:24:51.495] Timer tick, asking Buildbucket for the build status
[07:24:52.200] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:52.200] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:87:0) after 1m0s
[07:25:52.235] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:87:0)
[07:25:52.235] Timer tick, asking Buildbucket for the build status
[07:25:52.407] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:52.407] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:88:0) after 1m0s
[07:26:52.473] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:88:0)
[07:26:52.473] Timer tick, asking Buildbucket for the build status
[07:26:53.551] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:53.551] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:89:0) after 1m0s
[07:27:53.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:89:0)
[07:27:53.661] Timer tick, asking Buildbucket for the build status
[07:27:54.583] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:54.583] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:90:0) after 1m0s
[07:28:54.755] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:90:0)
[07:28:54.755] Timer tick, asking Buildbucket for the build status
[07:28:55.147] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:55.147] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:91:0) after 1m0s
[07:29:55.190] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:91:0)
[07:29:55.190] Timer tick, asking Buildbucket for the build status
[07:29:55.560] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:55.560] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:92:0) after 1m0s
[07:30:55.625] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:92:0)
[07:30:55.625] Timer tick, asking Buildbucket for the build status
[07:30:55.846] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:55.846] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:93:0) after 1m0s
[07:31:55.884] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:93:0)
[07:31:55.884] Timer tick, asking Buildbucket for the build status
[07:31:56.088] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:56.088] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:94:0) after 1m0s
[07:32:56.170] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:94:0)
[07:32:56.170] Timer tick, asking Buildbucket for the build status
[07:32:58.487] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:58.487] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:95:0) after 1m0s
[07:33:58.528] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:95:0)
[07:33:58.528] Timer tick, asking Buildbucket for the build status
[07:33:58.717] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:58.717] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:96:0) after 1m0s
[07:34:58.791] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:96:0)
[07:34:58.791] Timer tick, asking Buildbucket for the build status
[07:34:58.964] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:58.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:97:0) after 1m0s
[07:35:59.027] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:97:0)
[07:35:59.027] Timer tick, asking Buildbucket for the build status
[07:35:59.172] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:59.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:98:0) after 1m0s
[07:36:59.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:98:0)
[07:36:59.196] Timer tick, asking Buildbucket for the build status
[07:36:59.328] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:59.328] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:99:0) after 1m0s
[07:37:59.372] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:99:0)
[07:37:59.372] Timer tick, asking Buildbucket for the build status
[07:37:59.604] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:59.604] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:100:0) after 1m0s
[07:38:59.616] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:100:0)
[07:38:59.616] Timer tick, asking Buildbucket for the build status
[07:38:59.808] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:59.808] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:101:0) after 1m0s
[07:40:00.010] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:101:0)
[07:40:00.010] Timer tick, asking Buildbucket for the build status
[07:40:00.390] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:00.390] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:102:0) after 1m0s
[07:41:00.612] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:102:0)
[07:41:00.612] Timer tick, asking Buildbucket for the build status
[07:41:00.775] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:00.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:103:0) after 1m0s
[07:42:00.989] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:103:0)
[07:42:00.989] Timer tick, asking Buildbucket for the build status
[07:42:01.279] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:01.279] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:104:0) after 1m0s
[07:43:01.481] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:104:0)
[07:43:01.481] Timer tick, asking Buildbucket for the build status
[07:43:01.966] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:01.966] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:105:0) after 1m0s
[07:44:02.034] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:105:0)
[07:44:02.034] Timer tick, asking Buildbucket for the build status
[07:44:02.427] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:02.427] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:106:0) after 1m0s
[07:45:02.532] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:106:0)
[07:45:02.532] Timer tick, asking Buildbucket for the build status
[07:45:03.215] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:03.215] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:107:0) after 1m0s
[07:46:03.420] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:107:0)
[07:46:03.420] Timer tick, asking Buildbucket for the build status
[07:46:06.164] Build 8895660159300110480: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:06.164] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux:9061090221720031808:108:0) after 1m0s
[07:46:48.289] Received PubSub notification, asking Buildbucket for the build status
[07:46:51.166] Build 8895660159300110480: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:46:51.166] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574840807640397",
"created_by": "project:chromium",
"created_ts": "1574834400805154",
"id": "8895660159300110480",
"parameters_json": "{\"builder_name\": \"Deterministic Linux\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49e538770e303bea75e1d07cf913badc429e5e0b\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-42-nsmq\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux\", \"buildnumber\": 25853, \"got_angle_revision\": \"c373dfd84194eb79e8d1a03e6831741ad874d654\", \"got_dawn_revision\": \"74cebd68792d5788144f50511b3eb35134f9803e\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"49e538770e303bea75e1d07cf913badc429e5e0b\", \"got_revision_cp\": \"refs/heads/master@{#719513}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"663dcefa22ea5eec1b108feebaf40a683fb104ff\", \"got_v8_revision\": \"f1c7d33e17f4525debf020af2915a0d03821e352\", \"got_v8_revision_cp\": \"refs/heads/8.0.383@{#1}\", \"got_webrtc_revision\": \"c363982eeab3445ec960f26eea8653d3eb8c9fed\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29925}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"49e538770e303bea75e1d07cf913badc429e5e0b\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5c21095a1a129131be723eb555273fa4f1dc89f7e6d0ed0ea2c09e97b0cf5fcb_v2\", \"builder_78902ab2d70d1593a97658cf8910c0e117cf7950e257117b8c551c6fe1cfb403_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-42-nsmq\"], \"image\": [\"chrome-xenial-19112100-3085293b610\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4662-e230705\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574834404096648",
"status": "COMPLETED",
"status_changed_ts": "1574840808002223",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux/25853",
"builder:Deterministic Linux",
"buildset:commit/git/49e538770e303bea75e1d07cf913badc429e5e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49e538770e303bea75e1d07cf913badc429e5e0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061090221720031808",
"scheduler_job_id:chromium/Deterministic Linux",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8895660159300110480/+/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:48c4438066a90110",
"user_agent:luci-scheduler"
],
"updated_ts": "1574840808008393",
"url": "https://ci.chromium.org/b/8895660159300110480",
"utcnow_ts": "1574840811155782"
}
}
[07:46:51.166] Invocation finished in 1h46m52.053611413s with status SUCCEEDED