[09:47:14.708] New invocation is queued and will start shortly
[09:47:16.253] Starting the invocation (attempt 1)
[09:47:16.288] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[09:47:16.288] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[09:47:16.288] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9051835033206958512",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9051835033206958512",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master"
]
}
[09:47:17.135] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583660836427212",
"id": "8886404970740631664",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583660836964562",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16001",
"builder:Windows deterministic",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051835033206958512",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886404970740631664/+/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": "1583660836964728",
"url": "https://ci.chromium.org/b/8886404970740631664",
"utcnow_ts": "1583660837122509"
}
}
[09:47:17.135] Task URL: https://ci.chromium.org/b/8886404970740631664
[09:47:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:2:0) after 1m0s
[09:48:17.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:2:0)
[09:48:17.199] Timer tick, asking Buildbucket for the build status
[09:48:17.304] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:48:17.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:3:0) after 1m0s
[09:49:17.410] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:3:0)
[09:49:17.411] Timer tick, asking Buildbucket for the build status
[09:49:17.526] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:49:17.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:4:0) after 1m0s
[09:50:17.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:4:0)
[09:50:17.691] Timer tick, asking Buildbucket for the build status
[09:50:18.071] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:50:18.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:5:0) after 1m0s
[09:51:18.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:5:0)
[09:51:18.227] Timer tick, asking Buildbucket for the build status
[09:51:18.391] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:51:18.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:6:0) after 1m0s
[09:52:18.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:6:0)
[09:52:18.408] Timer tick, asking Buildbucket for the build status
[09:52:18.581] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:52:18.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:7:0) after 1m0s
[09:53:18.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:7:0)
[09:53:18.706] Timer tick, asking Buildbucket for the build status
[09:53:19.091] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:53:19.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:8:0) after 1m0s
[09:54:19.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:8:0)
[09:54:19.255] Timer tick, asking Buildbucket for the build status
[09:54:19.358] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:54:19.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:9:0) after 1m0s
[09:55:19.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:9:0)
[09:55:19.597] Timer tick, asking Buildbucket for the build status
[09:55:19.766] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:55:19.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:10:0) after 1m0s
[09:56:19.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:10:0)
[09:56:19.784] Timer tick, asking Buildbucket for the build status
[09:56:20.472] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:56:20.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:11:0) after 1m0s
[09:57:20.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:11:0)
[09:57:20.783] Timer tick, asking Buildbucket for the build status
[09:57:20.860] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:57:20.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:12:0) after 1m0s
[09:58:20.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:12:0)
[09:58:20.919] Timer tick, asking Buildbucket for the build status
[09:58:21.034] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:58:21.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:13:0) after 1m0s
[09:59:21.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:13:0)
[09:59:21.057] Timer tick, asking Buildbucket for the build status
[09:59:21.228] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[09:59:21.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:14:0) after 1m0s
[10:00:26.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:14:0)
[10:00:26.810] Timer tick, asking Buildbucket for the build status
[10:00:27.321] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:00:27.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:15:0) after 1m0s
[10:01:27.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:15:0)
[10:01:27.564] Timer tick, asking Buildbucket for the build status
[10:01:27.746] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:01:27.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:16:0) after 1m0s
[10:02:27.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:16:0)
[10:02:27.931] Timer tick, asking Buildbucket for the build status
[10:02:28.094] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:02:28.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:17:0) after 1m0s
[10:03:28.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:17:0)
[10:03:28.234] Timer tick, asking Buildbucket for the build status
[10:03:28.363] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:03:28.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:18:0) after 1m0s
[10:04:28.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:18:0)
[10:04:28.561] Timer tick, asking Buildbucket for the build status
[10:04:28.857] Build 8886404970740631664: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:04:28.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:19:0) after 1m0s
[10:05:26.193] Received PubSub notification, asking Buildbucket for the build status
[10:05:26.283] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:28.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:19:0)
[10:05:28.957] Timer tick, asking Buildbucket for the build status
[10:05:29.308] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:29.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:21:0) after 1m0s
[10:06:29.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:21:0)
[10:06:29.379] Timer tick, asking Buildbucket for the build status
[10:06:29.766] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:29.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:22:0) after 1m0s
[10:07:29.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:22:0)
[10:07:29.774] Timer tick, asking Buildbucket for the build status
[10:07:29.901] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:29.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:23:0) after 1m0s
[10:08:29.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:23:0)
[10:08:29.982] Timer tick, asking Buildbucket for the build status
[10:08:30.269] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:30.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:24:0) after 1m0s
[10:09:30.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:24:0)
[10:09:30.379] Timer tick, asking Buildbucket for the build status
[10:09:30.502] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:30.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:25:0) after 1m0s
[10:10:30.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:25:0)
[10:10:30.529] Timer tick, asking Buildbucket for the build status
[10:10:30.774] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:30.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:26:0) after 1m0s
[10:11:30.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:26:0)
[10:11:30.834] Timer tick, asking Buildbucket for the build status
[10:11:31.258] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:31.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:27:0) after 1m0s
[10:12:31.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:27:0)
[10:12:31.398] Timer tick, asking Buildbucket for the build status
[10:12:31.533] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:31.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:28:0) after 1m0s
[10:13:31.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:28:0)
[10:13:31.603] Timer tick, asking Buildbucket for the build status
[10:13:31.877] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:31.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:29:0) after 1m0s
[10:14:31.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:29:0)
[10:14:31.931] Timer tick, asking Buildbucket for the build status
[10:14:32.385] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:32.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:30:0) after 1m0s
[10:15:32.442] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:30:0)
[10:15:32.442] Timer tick, asking Buildbucket for the build status
[10:15:32.921] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:32.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:31:0) after 1m0s
[10:16:32.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:31:0)
[10:16:32.941] Timer tick, asking Buildbucket for the build status
[10:16:33.388] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:33.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:32:0) after 1m0s
[10:17:33.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:32:0)
[10:17:33.438] Timer tick, asking Buildbucket for the build status
[10:17:33.545] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:33.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:33:0) after 1m0s
[10:18:33.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:33:0)
[10:18:33.614] Timer tick, asking Buildbucket for the build status
[10:18:34.082] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:34.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:34:0) after 1m0s
[10:19:34.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:34:0)
[10:19:34.153] Timer tick, asking Buildbucket for the build status
[10:19:34.378] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:34.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:35:0) after 1m0s
[10:20:34.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:35:0)
[10:20:34.446] Timer tick, asking Buildbucket for the build status
[10:20:35.350] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:35.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:36:0) after 1m0s
[10:21:35.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:36:0)
[10:21:35.526] Timer tick, asking Buildbucket for the build status
[10:21:35.654] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:35.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:37:0) after 1m0s
[10:22:35.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:37:0)
[10:22:35.858] Timer tick, asking Buildbucket for the build status
[10:22:36.068] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:36.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:38:0) after 1m0s
[10:23:36.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:38:0)
[10:23:36.189] Timer tick, asking Buildbucket for the build status
[10:23:36.323] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:36.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:39:0) after 1m0s
[10:24:36.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:39:0)
[10:24:36.397] Timer tick, asking Buildbucket for the build status
[10:24:36.577] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:36.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:40:0) after 1m0s
[10:25:36.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:40:0)
[10:25:36.703] Timer tick, asking Buildbucket for the build status
[10:25:36.801] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:36.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:41:0) after 1m0s
[10:26:36.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:41:0)
[10:26:36.994] Timer tick, asking Buildbucket for the build status
[10:26:37.160] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:37.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:42:0) after 1m0s
[10:27:37.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:42:0)
[10:27:37.271] Timer tick, asking Buildbucket for the build status
[10:27:37.414] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:37.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:43:0) after 1m0s
[10:28:37.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:43:0)
[10:28:37.456] Timer tick, asking Buildbucket for the build status
[10:28:37.553] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:37.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:44:0) after 1m0s
[10:29:37.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:44:0)
[10:29:37.596] Timer tick, asking Buildbucket for the build status
[10:29:37.733] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:37.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:45:0) after 1m0s
[10:30:37.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:45:0)
[10:30:37.820] Timer tick, asking Buildbucket for the build status
[10:30:37.980] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:37.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:46:0) after 1m0s
[10:31:38.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:46:0)
[10:31:38.300] Timer tick, asking Buildbucket for the build status
[10:31:38.946] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:38.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:47:0) after 1m0s
[10:32:39.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:47:0)
[10:32:39.044] Timer tick, asking Buildbucket for the build status
[10:32:39.285] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:39.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:48:0) after 1m0s
[10:33:39.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:48:0)
[10:33:39.311] Timer tick, asking Buildbucket for the build status
[10:33:39.592] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:39.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:49:0) after 1m0s
[10:34:39.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:49:0)
[10:34:39.735] Timer tick, asking Buildbucket for the build status
[10:34:39.845] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:39.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:50:0) after 1m0s
[10:35:39.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:50:0)
[10:35:39.914] Timer tick, asking Buildbucket for the build status
[10:35:40.025] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:40.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:51:0) after 1m0s
[10:36:40.091] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:51:0)
[10:36:40.091] Timer tick, asking Buildbucket for the build status
[10:36:40.196] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:40.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:52:0) after 1m0s
[10:37:40.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:52:0)
[10:37:40.248] Timer tick, asking Buildbucket for the build status
[10:37:40.347] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:40.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:53:0) after 1m0s
[10:38:40.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:53:0)
[10:38:40.332] Timer tick, asking Buildbucket for the build status
[10:38:40.712] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:40.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:54:0) after 1m0s
[10:39:40.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:54:0)
[10:39:40.754] Timer tick, asking Buildbucket for the build status
[10:39:40.902] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:55:0) after 1m0s
[10:40:40.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:55:0)
[10:40:40.964] Timer tick, asking Buildbucket for the build status
[10:40:41.102] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:41.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:56:0) after 1m0s
[10:41:41.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:56:0)
[10:41:41.153] Timer tick, asking Buildbucket for the build status
[10:41:41.306] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:41.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:57:0) after 1m0s
[10:42:41.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:57:0)
[10:42:41.327] Timer tick, asking Buildbucket for the build status
[10:42:41.774] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:41.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:58:0) after 1m0s
[10:43:41.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:58:0)
[10:43:41.802] Timer tick, asking Buildbucket for the build status
[10:43:41.917] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:41.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:59:0) after 1m0s
[10:44:41.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:59:0)
[10:44:41.940] Timer tick, asking Buildbucket for the build status
[10:44:42.058] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:42.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:60:0) after 1m0s
[10:45:42.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:60:0)
[10:45:42.094] Timer tick, asking Buildbucket for the build status
[10:45:42.233] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:42.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:61:0) after 1m0s
[10:46:42.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:61:0)
[10:46:42.259] Timer tick, asking Buildbucket for the build status
[10:46:42.371] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:42.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:62:0) after 1m0s
[10:47:42.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:62:0)
[10:47:42.409] Timer tick, asking Buildbucket for the build status
[10:47:42.678] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:42.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:63:0) after 1m0s
[10:48:42.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:63:0)
[10:48:42.711] Timer tick, asking Buildbucket for the build status
[10:48:42.835] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:42.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:64:0) after 1m0s
[10:49:42.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:64:0)
[10:49:42.883] Timer tick, asking Buildbucket for the build status
[10:49:43.160] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:43.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:65:0) after 1m0s
[10:50:43.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:65:0)
[10:50:43.204] Timer tick, asking Buildbucket for the build status
[10:50:43.397] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:43.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:66:0) after 1m0s
[10:51:43.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:66:0)
[10:51:43.413] Timer tick, asking Buildbucket for the build status
[10:51:43.792] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:43.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:67:0) after 1m0s
[10:52:43.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:67:0)
[10:52:43.961] Timer tick, asking Buildbucket for the build status
[10:52:44.287] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:44.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:68:0) after 1m0s
[10:53:44.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:68:0)
[10:53:44.343] Timer tick, asking Buildbucket for the build status
[10:53:44.510] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:44.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:69:0) after 1m0s
[10:54:44.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:69:0)
[10:54:44.577] Timer tick, asking Buildbucket for the build status
[10:54:44.696] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:44.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:70:0) after 1m0s
[10:55:44.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:70:0)
[10:55:44.856] Timer tick, asking Buildbucket for the build status
[10:55:44.971] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:44.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:71:0) after 1m0s
[10:56:45.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:71:0)
[10:56:45.128] Timer tick, asking Buildbucket for the build status
[10:56:45.210] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:45.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:72:0) after 1m0s
[10:57:45.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:72:0)
[10:57:45.235] Timer tick, asking Buildbucket for the build status
[10:57:45.958] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:45.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:73:0) after 1m0s
[10:58:46.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:73:0)
[10:58:46.036] Timer tick, asking Buildbucket for the build status
[10:58:46.268] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:46.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:74:0) after 1m0s
[10:59:46.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:74:0)
[10:59:46.341] Timer tick, asking Buildbucket for the build status
[10:59:46.528] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:46.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:75:0) after 1m0s
[11:00:46.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:75:0)
[11:00:46.702] Timer tick, asking Buildbucket for the build status
[11:00:46.856] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:46.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:76:0) after 1m0s
[11:01:46.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:76:0)
[11:01:46.864] Timer tick, asking Buildbucket for the build status
[11:01:47.019] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:47.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:77:0) after 1m0s
[11:02:47.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:77:0)
[11:02:47.158] Timer tick, asking Buildbucket for the build status
[11:02:47.662] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:47.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:78:0) after 1m0s
[11:03:47.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:78:0)
[11:03:47.717] Timer tick, asking Buildbucket for the build status
[11:03:47.995] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:47.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:79:0) after 1m0s
[11:04:48.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:79:0)
[11:04:48.020] Timer tick, asking Buildbucket for the build status
[11:04:48.114] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:48.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:80:0) after 1m0s
[11:05:48.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:80:0)
[11:05:48.123] Timer tick, asking Buildbucket for the build status
[11:05:48.228] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:48.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:81:0) after 1m0s
[11:06:48.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:81:0)
[11:06:48.331] Timer tick, asking Buildbucket for the build status
[11:06:48.684] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:48.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:82:0) after 1m0s
[11:07:48.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:82:0)
[11:07:48.690] Timer tick, asking Buildbucket for the build status
[11:07:48.779] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:48.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:83:0) after 1m0s
[11:08:48.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:83:0)
[11:08:48.849] Timer tick, asking Buildbucket for the build status
[11:08:49.198] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:49.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:84:0) after 1m0s
[11:09:49.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:84:0)
[11:09:49.230] Timer tick, asking Buildbucket for the build status
[11:09:49.342] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:49.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:85:0) after 1m0s
[11:10:49.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:85:0)
[11:10:49.365] Timer tick, asking Buildbucket for the build status
[11:10:49.466] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:49.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:86:0) after 1m0s
[11:11:49.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:86:0)
[11:11:49.512] Timer tick, asking Buildbucket for the build status
[11:11:49.947] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:49.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:87:0) after 1m0s
[11:12:49.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:87:0)
[11:12:49.971] Timer tick, asking Buildbucket for the build status
[11:12:50.215] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:50.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:88:0) after 1m0s
[11:13:50.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:88:0)
[11:13:50.240] Timer tick, asking Buildbucket for the build status
[11:13:50.374] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:50.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:89:0) after 1m0s
[11:14:50.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:89:0)
[11:14:50.866] Timer tick, asking Buildbucket for the build status
[11:14:51.044] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:51.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:90:0) after 1m0s
[11:15:51.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:90:0)
[11:15:51.313] Timer tick, asking Buildbucket for the build status
[11:15:51.565] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:51.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:91:0) after 1m0s
[11:16:51.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:91:0)
[11:16:51.688] Timer tick, asking Buildbucket for the build status
[11:16:51.994] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:51.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:92:0) after 1m0s
[11:17:52.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:92:0)
[11:17:52.093] Timer tick, asking Buildbucket for the build status
[11:17:52.314] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:93:0) after 1m0s
[11:18:52.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:93:0)
[11:18:52.568] Timer tick, asking Buildbucket for the build status
[11:18:52.721] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:52.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:94:0) after 1m0s
[11:19:52.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:94:0)
[11:19:52.772] Timer tick, asking Buildbucket for the build status
[11:19:52.904] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:52.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:95:0) after 1m0s
[11:20:53.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:95:0)
[11:20:53.007] Timer tick, asking Buildbucket for the build status
[11:20:53.315] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:53.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:96:0) after 1m0s
[11:21:53.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:96:0)
[11:21:53.344] Timer tick, asking Buildbucket for the build status
[11:21:53.667] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:53.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:97:0) after 1m0s
[11:22:53.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:97:0)
[11:22:53.692] Timer tick, asking Buildbucket for the build status
[11:22:53.762] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:53.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:98:0) after 1m0s
[11:23:53.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:98:0)
[11:23:53.959] Timer tick, asking Buildbucket for the build status
[11:23:54.188] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:54.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:99:0) after 1m0s
[11:24:54.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:99:0)
[11:24:54.551] Timer tick, asking Buildbucket for the build status
[11:24:54.683] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:54.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:100:0) after 1m0s
[11:25:54.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:100:0)
[11:25:54.813] Timer tick, asking Buildbucket for the build status
[11:25:54.904] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:54.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:101:0) after 1m0s
[11:26:55.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:101:0)
[11:26:55.177] Timer tick, asking Buildbucket for the build status
[11:26:55.314] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:55.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:102:0) after 1m0s
[11:27:55.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:102:0)
[11:27:55.494] Timer tick, asking Buildbucket for the build status
[11:27:55.586] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:55.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:103:0) after 1m0s
[11:28:55.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:103:0)
[11:28:55.875] Timer tick, asking Buildbucket for the build status
[11:28:56.012] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:56.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:104:0) after 1m0s
[11:29:56.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:104:0)
[11:29:56.278] Timer tick, asking Buildbucket for the build status
[11:29:56.367] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:56.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:105:0) after 1m0s
[11:30:56.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:105:0)
[11:30:56.507] Timer tick, asking Buildbucket for the build status
[11:30:56.623] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:56.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:106:0) after 1m0s
[11:31:56.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:106:0)
[11:31:56.867] Timer tick, asking Buildbucket for the build status
[11:31:57.000] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:57.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:107:0) after 1m0s
[11:32:57.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:107:0)
[11:32:57.292] Timer tick, asking Buildbucket for the build status
[11:32:57.400] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:57.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:108:0) after 1m0s
[11:33:57.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:108:0)
[11:33:57.610] Timer tick, asking Buildbucket for the build status
[11:33:57.795] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:57.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:109:0) after 1m0s
[11:34:57.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:109:0)
[11:34:57.816] Timer tick, asking Buildbucket for the build status
[11:34:57.990] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:57.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:110:0) after 1m0s
[11:35:58.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:110:0)
[11:35:58.030] Timer tick, asking Buildbucket for the build status
[11:35:58.124] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:58.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:111:0) after 1m0s
[11:36:58.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:111:0)
[11:36:58.341] Timer tick, asking Buildbucket for the build status
[11:36:58.648] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:58.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:112:0) after 1m0s
[11:37:58.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:112:0)
[11:37:58.676] Timer tick, asking Buildbucket for the build status
[11:37:58.916] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:58.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:113:0) after 1m0s
[11:38:58.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:113:0)
[11:38:58.898] Timer tick, asking Buildbucket for the build status
[11:38:59.012] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:59.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:114:0) after 1m0s
[11:39:59.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:114:0)
[11:39:59.047] Timer tick, asking Buildbucket for the build status
[11:39:59.652] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:59.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:115:0) after 1m0s
[11:40:59.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:115:0)
[11:40:59.703] Timer tick, asking Buildbucket for the build status
[11:40:59.845] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:59.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:116:0) after 1m0s
[11:41:59.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:116:0)
[11:41:59.937] Timer tick, asking Buildbucket for the build status
[11:42:00.168] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:00.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:117:0) after 1m0s
[11:43:00.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:117:0)
[11:43:00.284] Timer tick, asking Buildbucket for the build status
[11:43:00.424] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:00.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:118:0) after 1m0s
[11:44:00.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:118:0)
[11:44:00.465] Timer tick, asking Buildbucket for the build status
[11:44:00.572] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:00.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:119:0) after 1m0s
[11:45:00.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:119:0)
[11:45:00.670] Timer tick, asking Buildbucket for the build status
[11:45:00.848] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:00.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:120:0) after 1m0s
[11:46:00.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:120:0)
[11:46:00.908] Timer tick, asking Buildbucket for the build status
[11:46:01.041] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:01.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:121:0) after 1m0s
[11:47:01.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:121:0)
[11:47:01.193] Timer tick, asking Buildbucket for the build status
[11:47:01.559] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:01.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:122:0) after 1m0s
[11:48:01.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:122:0)
[11:48:01.602] Timer tick, asking Buildbucket for the build status
[11:48:01.986] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:01.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:123:0) after 1m0s
[11:49:02.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:123:0)
[11:49:02.133] Timer tick, asking Buildbucket for the build status
[11:49:02.663] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:02.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:124:0) after 1m0s
[11:50:02.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:124:0)
[11:50:02.860] Timer tick, asking Buildbucket for the build status
[11:50:03.147] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:03.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:125:0) after 1m0s
[11:51:03.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:125:0)
[11:51:03.209] Timer tick, asking Buildbucket for the build status
[11:51:03.454] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:03.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:126:0) after 1m0s
[11:52:03.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:126:0)
[11:52:03.473] Timer tick, asking Buildbucket for the build status
[11:52:03.665] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:03.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:127:0) after 1m0s
[11:53:03.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:127:0)
[11:53:03.798] Timer tick, asking Buildbucket for the build status
[11:53:04.068] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:04.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:128:0) after 1m0s
[11:54:04.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:128:0)
[11:54:04.263] Timer tick, asking Buildbucket for the build status
[11:54:04.605] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:04.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:129:0) after 1m0s
[11:55:04.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:129:0)
[11:55:04.652] Timer tick, asking Buildbucket for the build status
[11:55:04.913] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:04.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:130:0) after 1m0s
[11:56:05.091] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:130:0)
[11:56:05.091] Timer tick, asking Buildbucket for the build status
[11:56:05.254] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:05.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:131:0) after 1m0s
[11:57:05.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:131:0)
[11:57:05.278] Timer tick, asking Buildbucket for the build status
[11:57:05.401] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:05.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:132:0) after 1m0s
[11:58:05.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:132:0)
[11:58:05.499] Timer tick, asking Buildbucket for the build status
[11:58:05.866] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:05.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:133:0) after 1m0s
[11:59:05.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:133:0)
[11:59:05.927] Timer tick, asking Buildbucket for the build status
[11:59:06.044] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:06.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:134:0) after 1m0s
[12:00:06.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:134:0)
[12:00:06.113] Timer tick, asking Buildbucket for the build status
[12:00:06.240] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:06.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:135:0) after 1m0s
[12:01:06.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:135:0)
[12:01:06.593] Timer tick, asking Buildbucket for the build status
[12:01:06.727] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:06.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:136:0) after 1m0s
[12:02:06.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:136:0)
[12:02:06.859] Timer tick, asking Buildbucket for the build status
[12:02:06.975] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:06.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:137:0) after 1m0s
[12:03:07.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:137:0)
[12:03:07.232] Timer tick, asking Buildbucket for the build status
[12:03:07.616] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:07.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:138:0) after 1m0s
[12:04:07.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:138:0)
[12:04:07.782] Timer tick, asking Buildbucket for the build status
[12:04:07.913] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:07.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:139:0) after 1m0s
[12:05:11.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:139:0)
[12:05:11.506] Timer tick, asking Buildbucket for the build status
[12:05:11.640] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:11.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:140:0) after 1m0s
[12:06:11.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:140:0)
[12:06:11.784] Timer tick, asking Buildbucket for the build status
[12:06:12.445] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:12.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:141:0) after 1m0s
[12:07:12.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:141:0)
[12:07:12.515] Timer tick, asking Buildbucket for the build status
[12:07:12.650] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:12.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:142:0) after 1m0s
[12:08:12.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:142:0)
[12:08:12.716] Timer tick, asking Buildbucket for the build status
[12:08:12.825] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:12.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:143:0) after 1m0s
[12:09:12.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:143:0)
[12:09:12.849] Timer tick, asking Buildbucket for the build status
[12:09:13.093] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:13.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:144:0) after 1m0s
[12:10:13.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:144:0)
[12:10:13.192] Timer tick, asking Buildbucket for the build status
[12:10:13.280] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:13.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:145:0) after 1m0s
[12:11:13.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:145:0)
[12:11:13.325] Timer tick, asking Buildbucket for the build status
[12:11:13.854] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:13.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:146:0) after 1m0s
[12:12:13.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:146:0)
[12:12:13.932] Timer tick, asking Buildbucket for the build status
[12:12:14.049] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:147:0) after 1m0s
[12:13:14.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:147:0)
[12:13:14.089] Timer tick, asking Buildbucket for the build status
[12:13:14.198] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:14.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:148:0) after 1m0s
[12:14:15.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:148:0)
[12:14:15.037] Timer tick, asking Buildbucket for the build status
[12:14:15.205] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:15.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:149:0) after 1m0s
[12:15:15.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:149:0)
[12:15:15.332] Timer tick, asking Buildbucket for the build status
[12:15:15.560] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:15.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:150:0) after 1m0s
[12:16:15.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:150:0)
[12:16:15.940] Timer tick, asking Buildbucket for the build status
[12:16:16.085] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:16.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:151:0) after 1m0s
[12:17:16.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:151:0)
[12:17:16.675] Timer tick, asking Buildbucket for the build status
[12:17:16.814] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:16.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:152:0) after 1m0s
[12:18:17.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:152:0)
[12:18:17.134] Timer tick, asking Buildbucket for the build status
[12:18:17.398] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:17.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:153:0) after 1m0s
[12:19:17.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:153:0)
[12:19:17.655] Timer tick, asking Buildbucket for the build status
[12:19:17.859] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:17.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:154:0) after 1m0s
[12:20:18.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:154:0)
[12:20:18.047] Timer tick, asking Buildbucket for the build status
[12:20:18.314] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:18.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:155:0) after 1m0s
[12:21:18.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:155:0)
[12:21:18.302] Timer tick, asking Buildbucket for the build status
[12:21:18.408] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:18.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:156:0) after 1m0s
[12:22:18.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:156:0)
[12:22:18.548] Timer tick, asking Buildbucket for the build status
[12:22:18.896] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:18.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:157:0) after 1m0s
[12:23:18.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:157:0)
[12:23:18.931] Timer tick, asking Buildbucket for the build status
[12:23:19.075] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:19.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:158:0) after 1m0s
[12:24:19.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:158:0)
[12:24:19.100] Timer tick, asking Buildbucket for the build status
[12:24:19.301] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:19.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:159:0) after 1m0s
[12:25:19.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:159:0)
[12:25:19.333] Timer tick, asking Buildbucket for the build status
[12:25:19.683] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:19.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:160:0) after 1m0s
[12:26:19.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:160:0)
[12:26:19.720] Timer tick, asking Buildbucket for the build status
[12:26:19.841] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:19.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:161:0) after 1m0s
[12:27:19.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:161:0)
[12:27:19.900] Timer tick, asking Buildbucket for the build status
[12:27:20.007] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:20.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:162:0) after 1m0s
[12:28:20.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:162:0)
[12:28:20.053] Timer tick, asking Buildbucket for the build status
[12:28:20.269] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:20.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:163:0) after 1m0s
[12:29:20.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:163:0)
[12:29:20.299] Timer tick, asking Buildbucket for the build status
[12:29:20.397] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:20.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:164:0) after 1m0s
[12:30:20.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:164:0)
[12:30:20.475] Timer tick, asking Buildbucket for the build status
[12:30:20.691] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:20.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:165:0) after 1m0s
[12:31:20.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:165:0)
[12:31:20.730] Timer tick, asking Buildbucket for the build status
[12:31:20.916] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:20.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:166:0) after 1m0s
[12:32:21.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:166:0)
[12:32:21.026] Timer tick, asking Buildbucket for the build status
[12:32:21.307] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:21.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:167:0) after 1m0s
[12:33:21.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:167:0)
[12:33:21.328] Timer tick, asking Buildbucket for the build status
[12:33:21.454] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:21.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:168:0) after 1m0s
[12:34:21.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:168:0)
[12:34:21.517] Timer tick, asking Buildbucket for the build status
[12:34:21.655] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:21.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:169:0) after 1m0s
[12:35:21.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:169:0)
[12:35:21.734] Timer tick, asking Buildbucket for the build status
[12:35:21.830] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:21.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:170:0) after 1m0s
[12:36:22.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:170:0)
[12:36:22.027] Timer tick, asking Buildbucket for the build status
[12:36:22.389] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:22.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:171:0) after 1m0s
[12:37:22.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:171:0)
[12:37:22.642] Timer tick, asking Buildbucket for the build status
[12:37:22.783] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:22.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:172:0) after 1m0s
[12:38:22.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:172:0)
[12:38:22.889] Timer tick, asking Buildbucket for the build status
[12:38:22.992] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:22.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:173:0) after 1m0s
[12:39:23.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:173:0)
[12:39:23.181] Timer tick, asking Buildbucket for the build status
[12:39:23.306] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:23.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:174:0) after 1m0s
[12:40:23.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:174:0)
[12:40:23.432] Timer tick, asking Buildbucket for the build status
[12:40:23.753] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:23.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:175:0) after 1m0s
[12:41:23.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:175:0)
[12:41:23.926] Timer tick, asking Buildbucket for the build status
[12:41:24.231] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:176:0) after 1m0s
[12:42:24.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:176:0)
[12:42:24.472] Timer tick, asking Buildbucket for the build status
[12:42:24.898] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:24.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:177:0) after 1m0s
[12:43:25.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:177:0)
[12:43:25.034] Timer tick, asking Buildbucket for the build status
[12:43:25.139] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:25.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:178:0) after 1m0s
[12:44:25.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:178:0)
[12:44:25.443] Timer tick, asking Buildbucket for the build status
[12:44:25.638] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:25.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:179:0) after 1m0s
[12:45:25.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:179:0)
[12:45:25.697] Timer tick, asking Buildbucket for the build status
[12:45:25.819] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:25.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:180:0) after 1m0s
[12:46:25.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:180:0)
[12:46:25.928] Timer tick, asking Buildbucket for the build status
[12:46:26.024] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:26.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:181:0) after 1m0s
[12:47:26.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:181:0)
[12:47:26.124] Timer tick, asking Buildbucket for the build status
[12:47:26.595] Build 8886404970740631664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:26.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9051835033206958512:182:0) after 1m0s
[12:48:08.845] Received PubSub notification, asking Buildbucket for the build status
[12:48:09.006] Build 8886404970740631664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:48:09.006] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583671687700485",
"created_by": "project:chromium",
"created_ts": "1583660836427212",
"id": "8886404970740631664",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-hcgc\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16001, \"got_angle_revision\": \"0c9b6abde90cbf6fd88fe4d86c2d66ef145607b5\", \"got_dawn_revision\": \"7d20b4450182b8e25dfd315019623d7a746cc290\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\", \"got_revision_cp\": \"refs/heads/master@{#748041}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"b44162fdbb25996e4710026007bc98b7201f2a1d\", \"got_v8_revision\": \"d4ed59c4ed609eacc9062bd22ebca409ef7c6d1c\", \"got_v8_revision_cp\": \"refs/heads/8.2.263@{#1}\", \"got_webrtc_revision\": \"04f7bfc4192f5ce444b312afd287203ea53c99b6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30715}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"52bb9bcf55601233224f95d162c028be0f5b0503\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-hcgc\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4851-268d16b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583661925535714",
"status": "COMPLETED",
"status_changed_ts": "1583671688244130",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16001",
"builder:Windows deterministic",
"buildset:commit/git/52bb9bcf55601233224f95d162c028be0f5b0503",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52bb9bcf55601233224f95d162c028be0f5b0503",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9051835033206958512",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8886404970740631664/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4ad25c31c89ab510",
"user_agent:luci-scheduler"
],
"updated_ts": "1583671688260869",
"url": "https://ci.chromium.org/b/8886404970740631664",
"utcnow_ts": "1583671688985261"
}
}
[12:48:09.006] Invocation finished in 3h0m54.313311213s with status SUCCEEDED