[08:34:16.430] New invocation is queued and will start shortly
[08:34:17.788] Starting the invocation (attempt 1)
[08:34:17.865] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:17.865] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:17.865] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060265142040256912",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"9ac179a7e71613d614a7b7afa4400df642730352\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9060265142040256912",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/9ac179a7e71613d614a7b7afa4400df642730352",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9ac179a7e71613d614a7b7afa4400df642730352",
"gitiles_ref:refs/heads/master"
]
}
[08:34:18.860] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575621258058579",
"id": "8894835079669274608",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9ac179a7e71613d614a7b7afa4400df642730352\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575621258575116",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15390",
"builder:Windows deterministic",
"buildset:commit/git/9ac179a7e71613d614a7b7afa4400df642730352",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9ac179a7e71613d614a7b7afa4400df642730352",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060265142040256912",
"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/8894835079669274608/+/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": "1575621258575777",
"url": "https://ci.chromium.org/b/8894835079669274608",
"utcnow_ts": "1575621258847172"
}
}
[08:34:18.860] Task URL: https://ci.chromium.org/b/8894835079669274608
[08:34:18.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:2:0) after 1m0s
[08:35:18.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:2:0)
[08:35:18.901] Timer tick, asking Buildbucket for the build status
[08:35:19.398] Build 8894835079669274608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:35:19.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:3:0) after 1m0s
[08:36:19.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:3:0)
[08:36:19.430] Timer tick, asking Buildbucket for the build status
[08:36:19.655] Build 8894835079669274608: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:36:19.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:4:0) after 1m0s
[08:36:25.040] Received PubSub notification, asking Buildbucket for the build status
[08:36:25.480] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:4:0)
[08:37:20.021] Timer tick, asking Buildbucket for the build status
[08:37:20.433] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:20.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:6:0) after 1m0s
[08:38:20.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:6:0)
[08:38:20.646] Timer tick, asking Buildbucket for the build status
[08:38:21.065] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:21.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:7:0) after 1m0s
[08:39:21.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:7:0)
[08:39:21.086] Timer tick, asking Buildbucket for the build status
[08:39:21.526] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:21.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:8:0) after 1m0s
[08:40:21.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:8:0)
[08:40:21.688] Timer tick, asking Buildbucket for the build status
[08:40:22.019] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:22.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:9:0) after 1m0s
[08:41:22.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:9:0)
[08:41:22.234] Timer tick, asking Buildbucket for the build status
[08:41:22.388] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:22.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:10:0) after 1m0s
[08:42:22.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:10:0)
[08:42:22.418] Timer tick, asking Buildbucket for the build status
[08:42:23.016] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:23.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:11:0) after 1m0s
[08:43:23.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:11:0)
[08:43:23.064] Timer tick, asking Buildbucket for the build status
[08:43:23.746] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:23.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:12:0) after 1m0s
[08:44:24.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:12:0)
[08:44:24.074] Timer tick, asking Buildbucket for the build status
[08:44:24.596] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:24.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:13:0) after 1m0s
[08:45:24.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:13:0)
[08:45:24.674] Timer tick, asking Buildbucket for the build status
[08:45:24.878] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:24.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:14:0) after 1m0s
[08:46:24.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:14:0)
[08:46:24.981] Timer tick, asking Buildbucket for the build status
[08:46:25.191] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:25.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:15:0) after 1m0s
[08:47:25.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:15:0)
[08:47:25.259] Timer tick, asking Buildbucket for the build status
[08:47:25.661] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:25.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:16:0) after 1m0s
[08:48:25.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:16:0)
[08:48:25.701] Timer tick, asking Buildbucket for the build status
[08:48:25.925] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:25.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:17:0) after 1m0s
[08:49:25.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:17:0)
[08:49:25.932] Timer tick, asking Buildbucket for the build status
[08:49:26.167] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:26.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:18:0) after 1m0s
[08:50:26.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:18:0)
[08:50:26.197] Timer tick, asking Buildbucket for the build status
[08:50:27.100] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:27.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:19:0) after 1m0s
[08:51:27.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:19:0)
[08:51:27.192] Timer tick, asking Buildbucket for the build status
[08:51:27.475] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:27.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:20:0) after 1m0s
[08:52:27.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:20:0)
[08:52:27.595] Timer tick, asking Buildbucket for the build status
[08:52:27.845] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:27.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:21:0) after 1m0s
[08:53:27.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:21:0)
[08:53:27.877] Timer tick, asking Buildbucket for the build status
[08:53:28.484] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:28.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:22:0) after 1m0s
[08:54:28.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:22:0)
[08:54:28.520] Timer tick, asking Buildbucket for the build status
[08:54:29.252] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:29.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:23:0) after 1m0s
[08:55:29.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:23:0)
[08:55:29.293] Timer tick, asking Buildbucket for the build status
[08:55:30.330] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:30.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:24:0) after 1m0s
[08:56:30.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:24:0)
[08:56:30.388] Timer tick, asking Buildbucket for the build status
[08:56:30.537] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:30.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:25:0) after 1m0s
[08:57:30.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:25:0)
[08:57:30.599] Timer tick, asking Buildbucket for the build status
[08:57:31.202] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:31.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:26:0) after 1m0s
[08:58:31.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:26:0)
[08:58:31.289] Timer tick, asking Buildbucket for the build status
[08:58:32.233] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:32.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:27:0) after 1m0s
[08:59:32.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:27:0)
[08:59:32.294] Timer tick, asking Buildbucket for the build status
[08:59:32.429] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:32.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:28:0) after 1m0s
[09:00:32.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:28:0)
[09:00:32.441] Timer tick, asking Buildbucket for the build status
[09:00:32.980] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:29:0) after 1m0s
[09:01:33.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:29:0)
[09:01:33.009] Timer tick, asking Buildbucket for the build status
[09:01:33.264] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:33.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:30:0) after 1m0s
[09:02:33.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:30:0)
[09:02:33.299] Timer tick, asking Buildbucket for the build status
[09:02:33.663] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:33.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:31:0) after 1m0s
[09:03:33.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:31:0)
[09:03:33.691] Timer tick, asking Buildbucket for the build status
[09:03:34.351] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:34.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:32:0) after 1m0s
[09:04:34.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:32:0)
[09:04:34.379] Timer tick, asking Buildbucket for the build status
[09:04:34.592] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:34.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:33:0) after 1m0s
[09:05:34.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:33:0)
[09:05:34.647] Timer tick, asking Buildbucket for the build status
[09:05:34.838] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:34.838] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:34:0) after 1m0s
[09:06:34.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:34:0)
[09:06:34.893] Timer tick, asking Buildbucket for the build status
[09:06:35.406] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:35.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:35:0) after 1m0s
[09:07:35.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:35:0)
[09:07:35.429] Timer tick, asking Buildbucket for the build status
[09:07:35.641] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:35.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:36:0) after 1m0s
[09:08:35.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:36:0)
[09:08:35.662] Timer tick, asking Buildbucket for the build status
[09:08:35.906] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:35.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:37:0) after 1m0s
[09:09:35.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:37:0)
[09:09:35.941] Timer tick, asking Buildbucket for the build status
[09:09:36.169] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:36.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:38:0) after 1m0s
[09:10:36.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:38:0)
[09:10:36.191] Timer tick, asking Buildbucket for the build status
[09:10:36.471] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:39:0) after 1m0s
[09:11:36.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:39:0)
[09:11:36.494] Timer tick, asking Buildbucket for the build status
[09:11:37.220] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:37.220] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:40:0) after 1m0s
[09:12:37.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:40:0)
[09:12:37.246] Timer tick, asking Buildbucket for the build status
[09:12:37.803] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:37.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:41:0) after 1m0s
[09:13:37.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:41:0)
[09:13:37.825] Timer tick, asking Buildbucket for the build status
[09:13:39.092] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:39.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:42:0) after 1m0s
[09:14:39.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:42:0)
[09:14:39.154] Timer tick, asking Buildbucket for the build status
[09:14:39.453] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:39.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:43:0) after 1m0s
[09:15:39.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:43:0)
[09:15:39.497] Timer tick, asking Buildbucket for the build status
[09:15:39.731] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:39.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:44:0) after 1m0s
[09:16:39.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:44:0)
[09:16:39.804] Timer tick, asking Buildbucket for the build status
[09:16:40.485] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:40.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:45:0) after 1m0s
[09:17:40.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:45:0)
[09:17:40.518] Timer tick, asking Buildbucket for the build status
[09:17:40.689] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:40.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:46:0) after 1m0s
[09:18:40.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:46:0)
[09:18:40.729] Timer tick, asking Buildbucket for the build status
[09:18:40.899] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:40.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:47:0) after 1m0s
[09:19:40.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:47:0)
[09:19:40.934] Timer tick, asking Buildbucket for the build status
[09:19:41.132] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:41.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:48:0) after 1m0s
[09:20:41.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:48:0)
[09:20:41.111] Timer tick, asking Buildbucket for the build status
[09:20:41.283] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:41.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:49:0) after 1m0s
[09:21:41.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:49:0)
[09:21:41.311] Timer tick, asking Buildbucket for the build status
[09:21:42.107] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:42.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:50:0) after 1m0s
[09:22:42.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:50:0)
[09:22:42.172] Timer tick, asking Buildbucket for the build status
[09:22:44.990] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:44.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:51:0) after 1m0s
[09:23:45.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:51:0)
[09:23:45.095] Timer tick, asking Buildbucket for the build status
[09:23:45.497] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:45.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:52:0) after 1m0s
[09:24:45.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:52:0)
[09:24:45.563] Timer tick, asking Buildbucket for the build status
[09:24:45.841] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:45.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:53:0) after 1m0s
[09:25:45.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:53:0)
[09:25:45.909] Timer tick, asking Buildbucket for the build status
[09:25:46.096] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:46.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:54:0) after 1m0s
[09:26:46.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:54:0)
[09:26:46.123] Timer tick, asking Buildbucket for the build status
[09:26:47.111] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:47.111] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:55:0) after 1m0s
[09:27:47.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:55:0)
[09:27:47.133] Timer tick, asking Buildbucket for the build status
[09:27:47.703] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:47.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:56:0) after 1m0s
[09:28:47.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:56:0)
[09:28:47.782] Timer tick, asking Buildbucket for the build status
[09:28:47.933] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:47.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:57:0) after 1m0s
[09:29:48.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:57:0)
[09:29:48.007] Timer tick, asking Buildbucket for the build status
[09:29:48.290] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:48.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:58:0) after 1m0s
[09:30:48.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:58:0)
[09:30:48.426] Timer tick, asking Buildbucket for the build status
[09:30:48.580] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:48.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:59:0) after 1m0s
[09:31:48.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:59:0)
[09:31:48.671] Timer tick, asking Buildbucket for the build status
[09:31:49.153] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:49.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:60:0) after 1m0s
[09:32:49.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:60:0)
[09:32:49.176] Timer tick, asking Buildbucket for the build status
[09:32:49.690] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:49.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:61:0) after 1m0s
[09:33:49.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:61:0)
[09:33:49.799] Timer tick, asking Buildbucket for the build status
[09:33:50.140] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:50.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:62:0) after 1m0s
[09:34:50.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:62:0)
[09:34:50.198] Timer tick, asking Buildbucket for the build status
[09:34:50.505] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:50.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:63:0) after 1m0s
[09:35:50.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:63:0)
[09:35:50.559] Timer tick, asking Buildbucket for the build status
[09:35:51.758] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:51.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:64:0) after 1m0s
[09:36:51.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:64:0)
[09:36:51.877] Timer tick, asking Buildbucket for the build status
[09:36:52.387] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:52.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:65:0) after 1m0s
[09:37:52.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:65:0)
[09:37:52.504] Timer tick, asking Buildbucket for the build status
[09:37:52.957] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:52.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:66:0) after 1m0s
[09:38:53.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:66:0)
[09:38:53.017] Timer tick, asking Buildbucket for the build status
[09:38:53.553] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:53.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:67:0) after 1m0s
[09:39:53.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:67:0)
[09:39:53.575] Timer tick, asking Buildbucket for the build status
[09:39:54.355] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:54.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:68:0) after 1m0s
[09:40:54.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:68:0)
[09:40:54.450] Timer tick, asking Buildbucket for the build status
[09:40:55.736] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:55.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:69:0) after 1m0s
[09:41:55.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:69:0)
[09:41:55.740] Timer tick, asking Buildbucket for the build status
[09:41:57.163] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:57.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:70:0) after 1m0s
[09:42:57.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:70:0)
[09:42:57.242] Timer tick, asking Buildbucket for the build status
[09:42:57.487] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:57.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:71:0) after 1m0s
[09:43:57.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:71:0)
[09:43:57.536] Timer tick, asking Buildbucket for the build status
[09:43:58.373] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:58.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:72:0) after 1m0s
[09:44:58.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:72:0)
[09:44:58.424] Timer tick, asking Buildbucket for the build status
[09:44:59.125] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:59.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:73:0) after 1m0s
[09:45:59.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:73:0)
[09:45:59.182] Timer tick, asking Buildbucket for the build status
[09:46:01.189] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:01.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:74:0) after 1m0s
[09:47:01.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:74:0)
[09:47:01.209] Timer tick, asking Buildbucket for the build status
[09:47:02.302] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:02.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:75:0) after 1m0s
[09:48:02.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:75:0)
[09:48:02.471] Timer tick, asking Buildbucket for the build status
[09:48:02.655] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:02.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:76:0) after 1m0s
[09:49:02.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:76:0)
[09:49:02.703] Timer tick, asking Buildbucket for the build status
[09:49:03.831] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:03.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:77:0) after 1m0s
[09:50:03.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:77:0)
[09:50:03.884] Timer tick, asking Buildbucket for the build status
[09:50:04.266] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:04.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:78:0) after 1m0s
[09:51:04.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:78:0)
[09:51:04.354] Timer tick, asking Buildbucket for the build status
[09:51:04.546] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:04.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:79:0) after 1m0s
[09:52:04.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:79:0)
[09:52:04.579] Timer tick, asking Buildbucket for the build status
[09:52:04.842] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:04.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:80:0) after 1m0s
[09:53:04.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:80:0)
[09:53:04.902] Timer tick, asking Buildbucket for the build status
[09:53:05.631] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:05.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:81:0) after 1m0s
[09:54:05.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:81:0)
[09:54:05.691] Timer tick, asking Buildbucket for the build status
[09:54:08.085] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:08.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:82:0) after 1m0s
[09:55:08.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:82:0)
[09:55:08.237] Timer tick, asking Buildbucket for the build status
[09:55:08.388] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:08.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:83:0) after 1m0s
[09:56:08.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:83:0)
[09:56:08.498] Timer tick, asking Buildbucket for the build status
[09:56:09.248] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:09.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:84:0) after 1m0s
[09:57:09.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:84:0)
[09:57:09.275] Timer tick, asking Buildbucket for the build status
[09:57:09.487] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:09.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:85:0) after 1m0s
[09:58:09.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:85:0)
[09:58:09.631] Timer tick, asking Buildbucket for the build status
[09:58:09.860] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:09.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:86:0) after 1m0s
[09:59:09.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:86:0)
[09:59:09.878] Timer tick, asking Buildbucket for the build status
[09:59:09.988] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:09.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:87:0) after 1m0s
[10:00:10.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:87:0)
[10:00:10.022] Timer tick, asking Buildbucket for the build status
[10:00:10.203] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:88:0) after 1m0s
[10:01:10.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:88:0)
[10:01:10.242] Timer tick, asking Buildbucket for the build status
[10:01:10.925] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:10.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:89:0) after 1m0s
[10:02:10.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:89:0)
[10:02:10.950] Timer tick, asking Buildbucket for the build status
[10:02:11.392] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:11.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:90:0) after 1m0s
[10:03:11.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:90:0)
[10:03:11.450] Timer tick, asking Buildbucket for the build status
[10:03:12.228] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:12.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:91:0) after 1m0s
[10:04:12.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:91:0)
[10:04:12.221] Timer tick, asking Buildbucket for the build status
[10:04:12.467] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:12.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:92:0) after 1m0s
[10:05:12.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:92:0)
[10:05:12.515] Timer tick, asking Buildbucket for the build status
[10:05:12.775] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:12.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:93:0) after 1m0s
[10:06:12.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:93:0)
[10:06:12.836] Timer tick, asking Buildbucket for the build status
[10:06:13.058] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:13.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:94:0) after 1m0s
[10:07:13.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:94:0)
[10:07:13.186] Timer tick, asking Buildbucket for the build status
[10:07:13.390] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:13.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:95:0) after 1m0s
[10:08:13.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:95:0)
[10:08:13.482] Timer tick, asking Buildbucket for the build status
[10:08:13.676] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:13.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:96:0) after 1m0s
[10:09:13.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:96:0)
[10:09:13.702] Timer tick, asking Buildbucket for the build status
[10:09:13.966] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:13.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:97:0) after 1m0s
[10:10:14.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:97:0)
[10:10:14.011] Timer tick, asking Buildbucket for the build status
[10:10:14.332] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:14.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:98:0) after 1m0s
[10:11:14.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:98:0)
[10:11:14.409] Timer tick, asking Buildbucket for the build status
[10:11:14.801] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:14.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:99:0) after 1m0s
[10:12:14.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:99:0)
[10:12:14.913] Timer tick, asking Buildbucket for the build status
[10:12:15.070] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:15.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:100:0) after 1m0s
[10:13:15.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:100:0)
[10:13:15.164] Timer tick, asking Buildbucket for the build status
[10:13:15.340] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:15.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:101:0) after 1m0s
[10:14:15.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:101:0)
[10:14:15.336] Timer tick, asking Buildbucket for the build status
[10:14:15.479] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:15.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:102:0) after 1m0s
[10:15:15.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:102:0)
[10:15:15.544] Timer tick, asking Buildbucket for the build status
[10:15:15.657] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:15.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:103:0) after 1m0s
[10:16:15.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:103:0)
[10:16:15.773] Timer tick, asking Buildbucket for the build status
[10:16:15.925] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:15.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:104:0) after 1m0s
[10:17:15.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:104:0)
[10:17:15.969] Timer tick, asking Buildbucket for the build status
[10:17:16.343] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:16.343] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:105:0) after 1m0s
[10:18:16.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:105:0)
[10:18:16.500] Timer tick, asking Buildbucket for the build status
[10:18:17.049] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:17.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:106:0) after 1m0s
[10:19:17.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:106:0)
[10:19:17.186] Timer tick, asking Buildbucket for the build status
[10:19:17.601] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:17.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:107:0) after 1m0s
[10:20:17.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:107:0)
[10:20:17.698] Timer tick, asking Buildbucket for the build status
[10:20:19.640] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:108:0) after 1m0s
[10:21:19.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:108:0)
[10:21:19.712] Timer tick, asking Buildbucket for the build status
[10:21:19.848] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:19.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:109:0) after 1m0s
[10:22:19.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:109:0)
[10:22:19.921] Timer tick, asking Buildbucket for the build status
[10:22:20.184] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:20.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:110:0) after 1m0s
[10:23:20.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:110:0)
[10:23:20.402] Timer tick, asking Buildbucket for the build status
[10:23:21.435] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:21.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:111:0) after 1m0s
[10:24:21.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:111:0)
[10:24:21.726] Timer tick, asking Buildbucket for the build status
[10:24:21.840] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:21.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:112:0) after 1m0s
[10:25:22.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:112:0)
[10:25:22.108] Timer tick, asking Buildbucket for the build status
[10:25:22.547] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:113:0) after 1m0s
[10:26:22.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:113:0)
[10:26:22.607] Timer tick, asking Buildbucket for the build status
[10:26:24.776] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:24.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:114:0) after 1m0s
[10:27:24.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:114:0)
[10:27:24.938] Timer tick, asking Buildbucket for the build status
[10:27:25.102] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:25.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:115:0) after 1m0s
[10:28:25.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:115:0)
[10:28:25.132] Timer tick, asking Buildbucket for the build status
[10:28:25.272] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:25.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:116:0) after 1m0s
[10:29:25.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:116:0)
[10:29:25.301] Timer tick, asking Buildbucket for the build status
[10:29:25.824] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:25.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:117:0) after 1m0s
[10:30:25.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:117:0)
[10:30:25.898] Timer tick, asking Buildbucket for the build status
[10:30:26.751] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:26.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:118:0) after 1m0s
[10:31:26.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:118:0)
[10:31:26.779] Timer tick, asking Buildbucket for the build status
[10:31:27.040] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:27.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:119:0) after 1m0s
[10:32:27.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:119:0)
[10:32:27.116] Timer tick, asking Buildbucket for the build status
[10:32:27.489] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:27.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:120:0) after 1m0s
[10:33:27.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:120:0)
[10:33:27.561] Timer tick, asking Buildbucket for the build status
[10:33:27.970] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:27.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:121:0) after 1m0s
[10:34:28.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:121:0)
[10:34:28.030] Timer tick, asking Buildbucket for the build status
[10:34:28.202] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:28.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:122:0) after 1m0s
[10:35:28.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:122:0)
[10:35:28.243] Timer tick, asking Buildbucket for the build status
[10:35:28.800] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:28.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:123:0) after 1m0s
[10:36:28.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:123:0)
[10:36:28.818] Timer tick, asking Buildbucket for the build status
[10:36:29.524] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:29.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:124:0) after 1m0s
[10:37:29.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:124:0)
[10:37:29.616] Timer tick, asking Buildbucket for the build status
[10:37:29.891] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:29.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:125:0) after 1m0s
[10:38:29.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:125:0)
[10:38:29.906] Timer tick, asking Buildbucket for the build status
[10:38:30.225] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:30.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:126:0) after 1m0s
[10:39:30.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:126:0)
[10:39:30.270] Timer tick, asking Buildbucket for the build status
[10:39:30.598] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:30.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:127:0) after 1m0s
[10:40:30.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:127:0)
[10:40:30.710] Timer tick, asking Buildbucket for the build status
[10:40:31.268] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:31.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:128:0) after 1m0s
[10:41:31.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:128:0)
[10:41:31.296] Timer tick, asking Buildbucket for the build status
[10:41:31.487] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:31.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:129:0) after 1m0s
[10:42:31.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:129:0)
[10:42:31.585] Timer tick, asking Buildbucket for the build status
[10:42:32.346] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:32.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:130:0) after 1m0s
[10:43:32.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:130:0)
[10:43:32.345] Timer tick, asking Buildbucket for the build status
[10:43:32.880] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:32.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:131:0) after 1m0s
[10:44:32.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:131:0)
[10:44:32.909] Timer tick, asking Buildbucket for the build status
[10:44:33.714] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:33.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:132:0) after 1m0s
[10:45:33.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:132:0)
[10:45:33.742] Timer tick, asking Buildbucket for the build status
[10:45:33.947] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:33.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:133:0) after 1m0s
[10:46:33.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:133:0)
[10:46:33.986] Timer tick, asking Buildbucket for the build status
[10:46:34.740] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:34.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:134:0) after 1m0s
[10:47:34.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:134:0)
[10:47:34.785] Timer tick, asking Buildbucket for the build status
[10:47:35.468] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:35.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:135:0) after 1m0s
[10:48:35.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:135:0)
[10:48:35.632] Timer tick, asking Buildbucket for the build status
[10:48:35.971] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:35.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:136:0) after 1m0s
[10:49:36.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:136:0)
[10:49:36.073] Timer tick, asking Buildbucket for the build status
[10:49:36.254] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:36.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:137:0) after 1m0s
[10:50:36.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:137:0)
[10:50:36.326] Timer tick, asking Buildbucket for the build status
[10:50:36.494] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:36.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:138:0) after 1m0s
[10:51:36.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:138:0)
[10:51:36.617] Timer tick, asking Buildbucket for the build status
[10:51:36.824] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:36.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:139:0) after 1m0s
[10:52:37.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:139:0)
[10:52:37.006] Timer tick, asking Buildbucket for the build status
[10:52:37.506] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:37.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:140:0) after 1m0s
[10:53:37.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:140:0)
[10:53:37.604] Timer tick, asking Buildbucket for the build status
[10:53:37.765] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:37.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:141:0) after 1m0s
[10:54:37.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:141:0)
[10:54:37.805] Timer tick, asking Buildbucket for the build status
[10:54:38.491] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:38.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:142:0) after 1m0s
[10:55:38.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:142:0)
[10:55:38.626] Timer tick, asking Buildbucket for the build status
[10:55:38.884] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:38.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:143:0) after 1m0s
[10:56:39.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:143:0)
[10:56:39.021] Timer tick, asking Buildbucket for the build status
[10:56:39.205] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:39.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:144:0) after 1m0s
[10:57:39.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:144:0)
[10:57:39.236] Timer tick, asking Buildbucket for the build status
[10:57:39.384] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:39.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:145:0) after 1m0s
[10:58:39.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:145:0)
[10:58:39.499] Timer tick, asking Buildbucket for the build status
[10:58:40.092] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:40.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:146:0) after 1m0s
[10:59:40.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:146:0)
[10:59:40.111] Timer tick, asking Buildbucket for the build status
[10:59:40.791] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:40.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:147:0) after 1m0s
[11:00:40.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:147:0)
[11:00:40.835] Timer tick, asking Buildbucket for the build status
[11:00:41.453] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:41.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:148:0) after 1m0s
[11:01:41.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:148:0)
[11:01:41.508] Timer tick, asking Buildbucket for the build status
[11:01:41.708] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:41.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:149:0) after 1m0s
[11:02:41.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:149:0)
[11:02:41.765] Timer tick, asking Buildbucket for the build status
[11:02:41.924] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:41.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:150:0) after 1m0s
[11:03:41.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:150:0)
[11:03:41.967] Timer tick, asking Buildbucket for the build status
[11:03:42.277] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:42.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:151:0) after 1m0s
[11:04:42.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:151:0)
[11:04:42.406] Timer tick, asking Buildbucket for the build status
[11:04:42.783] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:42.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:152:0) after 1m0s
[11:05:42.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:152:0)
[11:05:42.817] Timer tick, asking Buildbucket for the build status
[11:05:43.153] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:43.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:153:0) after 1m0s
[11:06:43.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:153:0)
[11:06:43.167] Timer tick, asking Buildbucket for the build status
[11:06:44.336] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:44.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:154:0) after 1m0s
[11:07:44.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:154:0)
[11:07:44.544] Timer tick, asking Buildbucket for the build status
[11:07:44.787] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:44.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:155:0) after 1m0s
[11:08:44.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:155:0)
[11:08:44.810] Timer tick, asking Buildbucket for the build status
[11:08:45.045] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:45.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:156:0) after 1m0s
[11:09:45.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:156:0)
[11:09:45.073] Timer tick, asking Buildbucket for the build status
[11:09:45.352] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:45.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:157:0) after 1m0s
[11:10:45.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:157:0)
[11:10:45.453] Timer tick, asking Buildbucket for the build status
[11:10:46.522] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:158:0) after 1m0s
[11:11:46.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:158:0)
[11:11:46.603] Timer tick, asking Buildbucket for the build status
[11:11:46.780] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:46.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:159:0) after 1m0s
[11:12:46.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:159:0)
[11:12:46.894] Timer tick, asking Buildbucket for the build status
[11:12:47.531] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:47.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:160:0) after 1m0s
[11:13:47.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:160:0)
[11:13:47.579] Timer tick, asking Buildbucket for the build status
[11:13:48.124] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:48.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:161:0) after 1m0s
[11:14:48.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:161:0)
[11:14:48.144] Timer tick, asking Buildbucket for the build status
[11:14:48.355] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:48.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:162:0) after 1m0s
[11:15:48.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:162:0)
[11:15:48.390] Timer tick, asking Buildbucket for the build status
[11:15:48.536] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:48.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:163:0) after 1m0s
[11:16:48.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:163:0)
[11:16:48.667] Timer tick, asking Buildbucket for the build status
[11:16:48.923] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:48.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:164:0) after 1m0s
[11:17:49.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:164:0)
[11:17:49.077] Timer tick, asking Buildbucket for the build status
[11:17:49.578] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:49.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:165:0) after 1m0s
[11:18:49.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:165:0)
[11:18:49.662] Timer tick, asking Buildbucket for the build status
[11:18:49.807] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:49.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:166:0) after 1m0s
[11:19:49.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:166:0)
[11:19:49.862] Timer tick, asking Buildbucket for the build status
[11:19:50.038] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:50.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:167:0) after 1m0s
[11:20:50.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:167:0)
[11:20:50.138] Timer tick, asking Buildbucket for the build status
[11:20:51.558] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:51.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:168:0) after 1m0s
[11:21:51.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:168:0)
[11:21:51.610] Timer tick, asking Buildbucket for the build status
[11:21:52.147] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:52.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:169:0) after 1m0s
[11:22:52.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:169:0)
[11:22:52.215] Timer tick, asking Buildbucket for the build status
[11:22:52.911] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:52.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:170:0) after 1m0s
[11:23:52.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:170:0)
[11:23:52.917] Timer tick, asking Buildbucket for the build status
[11:23:53.209] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:53.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:171:0) after 1m0s
[11:24:53.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:171:0)
[11:24:53.292] Timer tick, asking Buildbucket for the build status
[11:24:53.551] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:53.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:172:0) after 1m0s
[11:25:53.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:172:0)
[11:25:53.634] Timer tick, asking Buildbucket for the build status
[11:25:53.777] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:53.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:173:0) after 1m0s
[11:26:53.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:173:0)
[11:26:53.868] Timer tick, asking Buildbucket for the build status
[11:26:54.019] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:54.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:174:0) after 1m0s
[11:27:54.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:174:0)
[11:27:54.153] Timer tick, asking Buildbucket for the build status
[11:27:56.947] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:56.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:175:0) after 1m0s
[11:28:57.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:175:0)
[11:28:57.004] Timer tick, asking Buildbucket for the build status
[11:28:57.174] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:57.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:176:0) after 1m0s
[11:29:57.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:176:0)
[11:29:57.249] Timer tick, asking Buildbucket for the build status
[11:29:57.430] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:177:0) after 1m0s
[11:30:57.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:177:0)
[11:30:57.475] Timer tick, asking Buildbucket for the build status
[11:30:58.312] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:58.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:178:0) after 1m0s
[11:31:58.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:178:0)
[11:31:58.380] Timer tick, asking Buildbucket for the build status
[11:31:58.624] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:58.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:179:0) after 1m0s
[11:32:58.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:179:0)
[11:32:58.717] Timer tick, asking Buildbucket for the build status
[11:32:58.874] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:58.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:180:0) after 1m0s
[11:33:58.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:180:0)
[11:33:58.908] Timer tick, asking Buildbucket for the build status
[11:33:59.214] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:59.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:181:0) after 1m0s
[11:34:59.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:181:0)
[11:34:59.253] Timer tick, asking Buildbucket for the build status
[11:34:59.461] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:59.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:182:0) after 1m0s
[11:35:59.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:182:0)
[11:35:59.624] Timer tick, asking Buildbucket for the build status
[11:35:59.769] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:59.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:183:0) after 1m0s
[11:36:59.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:183:0)
[11:36:59.829] Timer tick, asking Buildbucket for the build status
[11:37:00.493] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:00.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:184:0) after 1m0s
[11:38:00.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:184:0)
[11:38:00.626] Timer tick, asking Buildbucket for the build status
[11:38:00.782] Build 8894835079669274608: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:00.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060265142040256912:185:0) after 1m0s
[11:38:06.232] Received PubSub notification, asking Buildbucket for the build status
[11:38:06.688] Build 8894835079669274608: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:38:06.688] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575632284880130",
"created_by": "project:chromium",
"created_ts": "1575621258058579",
"id": "8894835079669274608",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9ac179a7e71613d614a7b7afa4400df642730352\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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-lz5n\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15390, \"got_angle_revision\": \"11e6944ec5a84a780c495bbf6d3edf04404e0539\", \"got_dawn_revision\": \"1d6250d0164578f8f8ec7a7147aaab67066ae764\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"9ac179a7e71613d614a7b7afa4400df642730352\", \"got_revision_cp\": \"refs/heads/master@{#722406}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"b9f03f47d5f552905f1003ada49729240a7ca2c4\", \"got_v8_revision\": \"69827db645fcece065bf16a795a4ec8d3a51057f\", \"got_v8_revision_cp\": \"refs/heads/8.0.426@{#2}\", \"got_webrtc_revision\": \"1256d9bcac500d962e884231b0360d8c3eb3ef02\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30022}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"9ac179a7e71613d614a7b7afa4400df642730352\"}, \"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\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-lz5n\"], \"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\": [\"4702-f6d98f9\"], \"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": "1575621383966708",
"status": "COMPLETED",
"status_changed_ts": "1575632285136128",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15390",
"builder:Windows deterministic",
"buildset:commit/git/9ac179a7e71613d614a7b7afa4400df642730352",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9ac179a7e71613d614a7b7afa4400df642730352",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060265142040256912",
"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/8894835079669274608/+/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:48f329f8b3de0710",
"user_agent:luci-scheduler"
],
"updated_ts": "1575632285139185",
"url": "https://ci.chromium.org/b/8894835079669274608",
"utcnow_ts": "1575632286666183"
}
}
[11:38:06.688] Invocation finished in 3h3m50.274879728s with status SUCCEEDED