[19:08:54.786] New invocation is queued and will start shortly
[19:08:56.462] Starting the invocation (attempt 1)
[19:08:56.522] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:08:56.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:08:56.522] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059772229159318912",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"5b786fa53c5b7661c17a57ffdc96983aed0900b4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9059772229159318912",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"gitiles_ref:refs/heads/master"
]
}
[19:08:57.821] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576091336996902",
"id": "8894342166176634464",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b786fa53c5b7661c17a57ffdc96983aed0900b4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576091337650243",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15435",
"builder:Windows deterministic",
"buildset:commit/git/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059772229159318912",
"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/8894342166176634464/+/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": "1576091337650414",
"url": "https://ci.chromium.org/b/8894342166176634464",
"utcnow_ts": "1576091337808138"
}
}
[19:08:57.821] Task URL: https://ci.chromium.org/b/8894342166176634464
[19:08:57.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:2:0) after 1m0s
[19:09:28.287] Received PubSub notification, asking Buildbucket for the build status
[19:09:29.995] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:57.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:2:0)
[19:09:57.828] Timer tick, asking Buildbucket for the build status
[19:09:58.303] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:58.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:4:0) after 1m0s
[19:10:58.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:4:0)
[19:10:58.342] Timer tick, asking Buildbucket for the build status
[19:10:59.348] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:59.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:5:0) after 1m0s
[19:11:59.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:5:0)
[19:11:59.371] Timer tick, asking Buildbucket for the build status
[19:11:59.907] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:59.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:6:0) after 1m0s
[19:12:59.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:6:0)
[19:12:59.973] Timer tick, asking Buildbucket for the build status
[19:13:00.113] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:00.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:7:0) after 1m0s
[19:14:00.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:7:0)
[19:14:00.126] Timer tick, asking Buildbucket for the build status
[19:14:00.586] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:00.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:8:0) after 1m0s
[19:15:00.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:8:0)
[19:15:00.958] Timer tick, asking Buildbucket for the build status
[19:15:01.179] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:01.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:9:0) after 1m0s
[19:16:01.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:9:0)
[19:16:01.203] Timer tick, asking Buildbucket for the build status
[19:16:01.379] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:01.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:10:0) after 1m0s
[19:17:01.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:10:0)
[19:17:01.400] Timer tick, asking Buildbucket for the build status
[19:17:01.649] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:01.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:11:0) after 1m0s
[19:18:01.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:11:0)
[19:18:01.775] Timer tick, asking Buildbucket for the build status
[19:18:02.382] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:02.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:12:0) after 1m0s
[19:19:02.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:12:0)
[19:19:02.413] Timer tick, asking Buildbucket for the build status
[19:19:02.898] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:02.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:13:0) after 1m0s
[19:20:02.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:13:0)
[19:20:02.987] Timer tick, asking Buildbucket for the build status
[19:20:04.060] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:04.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:14:0) after 1m0s
[19:21:04.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:14:0)
[19:21:04.084] Timer tick, asking Buildbucket for the build status
[19:21:04.349] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:04.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:15:0) after 1m0s
[19:22:04.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:15:0)
[19:22:04.406] Timer tick, asking Buildbucket for the build status
[19:22:07.160] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:07.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:16:0) after 1m0s
[19:23:07.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:16:0)
[19:23:07.224] Timer tick, asking Buildbucket for the build status
[19:23:07.668] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:07.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:17:0) after 1m0s
[19:24:07.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:17:0)
[19:24:07.702] Timer tick, asking Buildbucket for the build status
[19:24:07.926] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:07.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:18:0) after 1m0s
[19:25:08.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:18:0)
[19:25:08.281] Timer tick, asking Buildbucket for the build status
[19:25:08.466] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:08.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:19:0) after 1m0s
[19:26:08.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:19:0)
[19:26:08.541] Timer tick, asking Buildbucket for the build status
[19:26:09.274] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:09.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:20:0) after 1m0s
[19:27:09.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:20:0)
[19:27:09.389] Timer tick, asking Buildbucket for the build status
[19:27:09.596] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:09.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:21:0) after 1m0s
[19:28:09.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:21:0)
[19:28:09.632] Timer tick, asking Buildbucket for the build status
[19:28:09.903] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:09.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:22:0) after 1m0s
[19:29:10.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:22:0)
[19:29:10.142] Timer tick, asking Buildbucket for the build status
[19:29:10.376] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:10.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:23:0) after 1m0s
[19:30:10.644] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:23:0)
[19:30:10.644] Timer tick, asking Buildbucket for the build status
[19:30:10.884] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:10.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:24:0) after 1m0s
[19:31:10.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:24:0)
[19:31:10.992] Timer tick, asking Buildbucket for the build status
[19:31:11.468] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:11.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:25:0) after 1m0s
[19:32:11.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:25:0)
[19:32:11.688] Timer tick, asking Buildbucket for the build status
[19:32:12.139] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:12.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:26:0) after 1m0s
[19:33:12.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:26:0)
[19:33:12.689] Timer tick, asking Buildbucket for the build status
[19:33:12.843] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:12.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:27:0) after 1m0s
[19:34:12.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:27:0)
[19:34:12.985] Timer tick, asking Buildbucket for the build status
[19:34:14.848] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:14.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:28:0) after 1m0s
[19:35:14.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:28:0)
[19:35:14.936] Timer tick, asking Buildbucket for the build status
[19:35:15.206] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:15.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:29:0) after 1m0s
[19:36:15.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:29:0)
[19:36:15.519] Timer tick, asking Buildbucket for the build status
[19:36:15.785] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:15.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:30:0) after 1m0s
[19:37:15.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:30:0)
[19:37:15.994] Timer tick, asking Buildbucket for the build status
[19:37:16.178] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:16.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:31:0) after 1m0s
[19:38:16.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:31:0)
[19:38:16.389] Timer tick, asking Buildbucket for the build status
[19:38:17.508] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:17.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:32:0) after 1m0s
[19:39:17.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:32:0)
[19:39:17.551] Timer tick, asking Buildbucket for the build status
[19:39:18.533] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:18.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:33:0) after 1m0s
[19:40:18.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:33:0)
[19:40:18.654] Timer tick, asking Buildbucket for the build status
[19:40:19.082] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:19.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:34:0) after 1m0s
[19:41:19.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:34:0)
[19:41:19.155] Timer tick, asking Buildbucket for the build status
[19:41:19.751] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:19.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:35:0) after 1m0s
[19:42:19.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:35:0)
[19:42:19.810] Timer tick, asking Buildbucket for the build status
[19:42:20.248] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:20.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:36:0) after 1m0s
[19:43:20.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:36:0)
[19:43:20.368] Timer tick, asking Buildbucket for the build status
[19:43:20.915] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:20.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:37:0) after 1m0s
[19:44:21.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:37:0)
[19:44:21.174] Timer tick, asking Buildbucket for the build status
[19:44:21.976] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:21.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:38:0) after 1m0s
[19:45:22.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:38:0)
[19:45:22.323] Timer tick, asking Buildbucket for the build status
[19:45:23.066] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:23.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:39:0) after 1m0s
[19:46:23.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:39:0)
[19:46:23.847] Timer tick, asking Buildbucket for the build status
[19:46:24.064] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:24.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:40:0) after 1m0s
[19:47:24.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:40:0)
[19:47:24.222] Timer tick, asking Buildbucket for the build status
[19:47:24.664] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:24.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:41:0) after 1m0s
[19:48:24.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:41:0)
[19:48:24.872] Timer tick, asking Buildbucket for the build status
[19:48:25.775] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:25.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:42:0) after 1m0s
[19:49:26.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:42:0)
[19:49:26.208] Timer tick, asking Buildbucket for the build status
[19:49:27.580] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:27.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:43:0) after 1m0s
[19:50:27.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:43:0)
[19:50:27.799] Timer tick, asking Buildbucket for the build status
[19:50:28.652] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:28.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:44:0) after 1m0s
[19:51:28.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:44:0)
[19:51:28.696] Timer tick, asking Buildbucket for the build status
[19:51:29.382] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:29.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:45:0) after 1m0s
[19:52:29.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:45:0)
[19:52:29.450] Timer tick, asking Buildbucket for the build status
[19:52:31.917] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:31.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:46:0) after 1m0s
[19:53:32.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:46:0)
[19:53:32.023] Timer tick, asking Buildbucket for the build status
[19:53:33.125] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:33.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:47:0) after 1m0s
[19:54:33.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:47:0)
[19:54:33.200] Timer tick, asking Buildbucket for the build status
[19:54:33.373] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:33.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:48:0) after 1m0s
[19:55:33.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:48:0)
[19:55:33.481] Timer tick, asking Buildbucket for the build status
[19:55:33.683] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:33.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:49:0) after 1m0s
[19:56:34.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:49:0)
[19:56:34.378] Timer tick, asking Buildbucket for the build status
[19:56:34.690] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:50:0) after 1m0s
[19:57:34.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:50:0)
[19:57:34.790] Timer tick, asking Buildbucket for the build status
[19:57:35.558] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:35.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:51:0) after 1m0s
[19:58:35.645] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:51:0)
[19:58:35.645] Timer tick, asking Buildbucket for the build status
[19:58:35.832] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:35.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:52:0) after 1m0s
[19:59:36.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:52:0)
[19:59:36.295] Timer tick, asking Buildbucket for the build status
[19:59:36.586] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:36.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:53:0) after 1m0s
[20:00:36.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:53:0)
[20:00:36.923] Timer tick, asking Buildbucket for the build status
[20:00:37.150] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:37.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:54:0) after 1m0s
[20:01:37.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:54:0)
[20:01:37.760] Timer tick, asking Buildbucket for the build status
[20:01:37.974] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:37.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:55:0) after 1m0s
[20:02:38.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:55:0)
[20:02:38.149] Timer tick, asking Buildbucket for the build status
[20:02:39.040] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:39.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:56:0) after 1m0s
[20:03:39.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:56:0)
[20:03:39.540] Timer tick, asking Buildbucket for the build status
[20:03:39.992] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:39.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:57:0) after 1m0s
[20:04:40.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:57:0)
[20:04:40.323] Timer tick, asking Buildbucket for the build status
[20:04:40.518] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:40.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:58:0) after 1m0s
[20:05:40.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:58:0)
[20:05:40.672] Timer tick, asking Buildbucket for the build status
[20:05:41.123] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:41.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:59:0) after 1m0s
[20:06:41.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:59:0)
[20:06:41.201] Timer tick, asking Buildbucket for the build status
[20:06:41.776] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:41.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:60:0) after 1m0s
[20:07:41.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:60:0)
[20:07:41.831] Timer tick, asking Buildbucket for the build status
[20:07:42.060] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:42.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:61:0) after 1m0s
[20:08:42.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:61:0)
[20:08:42.207] Timer tick, asking Buildbucket for the build status
[20:08:42.568] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:42.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:62:0) after 1m0s
[20:09:42.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:62:0)
[20:09:42.660] Timer tick, asking Buildbucket for the build status
[20:09:44.266] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:44.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:63:0) after 1m0s
[20:10:44.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:63:0)
[20:10:44.547] Timer tick, asking Buildbucket for the build status
[20:10:45.487] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:45.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:64:0) after 1m0s
[20:11:45.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:64:0)
[20:11:45.530] Timer tick, asking Buildbucket for the build status
[20:11:45.869] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:45.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:65:0) after 1m0s
[20:12:46.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:65:0)
[20:12:46.005] Timer tick, asking Buildbucket for the build status
[20:12:46.639] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:46.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:66:0) after 1m0s
[20:13:46.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:66:0)
[20:13:46.676] Timer tick, asking Buildbucket for the build status
[20:13:47.116] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:47.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:67:0) after 1m0s
[20:14:47.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:67:0)
[20:14:47.144] Timer tick, asking Buildbucket for the build status
[20:14:49.149] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:49.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:68:0) after 1m0s
[20:15:49.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:68:0)
[20:15:49.336] Timer tick, asking Buildbucket for the build status
[20:15:49.876] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:49.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:69:0) after 1m0s
[20:16:49.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:69:0)
[20:16:49.867] Timer tick, asking Buildbucket for the build status
[20:16:50.393] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:50.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:70:0) after 1m0s
[20:17:50.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:70:0)
[20:17:50.474] Timer tick, asking Buildbucket for the build status
[20:17:50.653] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:50.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:71:0) after 1m0s
[20:18:50.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:71:0)
[20:18:50.722] Timer tick, asking Buildbucket for the build status
[20:18:51.105] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:51.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:72:0) after 1m0s
[20:19:51.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:72:0)
[20:19:51.216] Timer tick, asking Buildbucket for the build status
[20:19:51.536] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:51.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:73:0) after 1m0s
[20:20:51.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:73:0)
[20:20:51.667] Timer tick, asking Buildbucket for the build status
[20:20:51.850] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:51.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:74:0) after 1m0s
[20:21:51.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:74:0)
[20:21:51.849] Timer tick, asking Buildbucket for the build status
[20:21:52.155] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:52.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:75:0) after 1m0s
[20:22:52.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:75:0)
[20:22:52.132] Timer tick, asking Buildbucket for the build status
[20:22:52.534] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:52.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:76:0) after 1m0s
[20:23:52.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:76:0)
[20:23:52.619] Timer tick, asking Buildbucket for the build status
[20:23:52.855] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:52.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:77:0) after 1m0s
[20:24:52.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:77:0)
[20:24:52.943] Timer tick, asking Buildbucket for the build status
[20:24:53.377] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:53.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:78:0) after 1m0s
[20:25:53.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:78:0)
[20:25:53.571] Timer tick, asking Buildbucket for the build status
[20:25:53.875] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:53.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:79:0) after 1m0s
[20:26:53.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:79:0)
[20:26:53.916] Timer tick, asking Buildbucket for the build status
[20:26:54.717] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:54.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:80:0) after 1m0s
[20:27:54.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:80:0)
[20:27:54.856] Timer tick, asking Buildbucket for the build status
[20:27:55.237] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:55.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:81:0) after 1m0s
[20:28:55.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:81:0)
[20:28:55.304] Timer tick, asking Buildbucket for the build status
[20:28:55.834] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:55.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:82:0) after 1m0s
[20:29:56.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:82:0)
[20:29:56.058] Timer tick, asking Buildbucket for the build status
[20:29:57.944] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:57.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:83:0) after 1m0s
[20:30:58.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:83:0)
[20:30:58.217] Timer tick, asking Buildbucket for the build status
[20:30:58.444] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:84:0) after 1m0s
[20:31:58.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:84:0)
[20:31:58.510] Timer tick, asking Buildbucket for the build status
[20:31:58.789] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:58.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:85:0) after 1m0s
[20:32:58.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:85:0)
[20:32:58.910] Timer tick, asking Buildbucket for the build status
[20:32:59.087] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:59.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:86:0) after 1m0s
[20:33:59.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:86:0)
[20:33:59.143] Timer tick, asking Buildbucket for the build status
[20:34:01.388] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:01.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:87:0) after 1m0s
[20:35:01.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:87:0)
[20:35:01.663] Timer tick, asking Buildbucket for the build status
[20:35:01.944] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:01.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:88:0) after 1m0s
[20:36:02.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:88:0)
[20:36:02.095] Timer tick, asking Buildbucket for the build status
[20:36:02.937] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:02.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:89:0) after 1m0s
[20:37:02.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:89:0)
[20:37:02.983] Timer tick, asking Buildbucket for the build status
[20:37:03.291] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:03.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:90:0) after 1m0s
[20:38:03.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:90:0)
[20:38:03.377] Timer tick, asking Buildbucket for the build status
[20:38:05.642] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:05.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:91:0) after 1m0s
[20:39:05.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:91:0)
[20:39:05.920] Timer tick, asking Buildbucket for the build status
[20:39:06.216] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:06.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:92:0) after 1m0s
[20:40:06.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:92:0)
[20:40:06.269] Timer tick, asking Buildbucket for the build status
[20:40:06.568] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:06.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:93:0) after 1m0s
[20:41:06.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:93:0)
[20:41:06.546] Timer tick, asking Buildbucket for the build status
[20:41:06.775] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:06.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:94:0) after 1m0s
[20:42:06.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:94:0)
[20:42:06.978] Timer tick, asking Buildbucket for the build status
[20:42:07.218] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:07.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:95:0) after 1m0s
[20:43:07.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:95:0)
[20:43:07.282] Timer tick, asking Buildbucket for the build status
[20:43:07.500] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:07.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:96:0) after 1m0s
[20:44:07.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:96:0)
[20:44:07.548] Timer tick, asking Buildbucket for the build status
[20:44:07.939] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:07.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:97:0) after 1m0s
[20:45:08.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:97:0)
[20:45:08.045] Timer tick, asking Buildbucket for the build status
[20:45:09.291] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:09.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:98:0) after 1m0s
[20:46:09.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:98:0)
[20:46:09.448] Timer tick, asking Buildbucket for the build status
[20:46:09.583] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:09.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:99:0) after 1m0s
[20:47:09.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:99:0)
[20:47:09.719] Timer tick, asking Buildbucket for the build status
[20:47:10.032] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:10.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:100:0) after 1m0s
[20:48:10.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:100:0)
[20:48:10.487] Timer tick, asking Buildbucket for the build status
[20:48:10.693] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:10.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:101:0) after 1m0s
[20:49:11.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:101:0)
[20:49:11.213] Timer tick, asking Buildbucket for the build status
[20:49:12.229] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:12.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:102:0) after 1m0s
[20:50:12.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:102:0)
[20:50:12.278] Timer tick, asking Buildbucket for the build status
[20:50:13.487] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:13.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:103:0) after 1m0s
[20:51:13.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:103:0)
[20:51:13.940] Timer tick, asking Buildbucket for the build status
[20:51:14.236] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:14.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:104:0) after 1m0s
[20:52:14.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:104:0)
[20:52:14.388] Timer tick, asking Buildbucket for the build status
[20:52:14.567] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:14.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:105:0) after 1m0s
[20:53:14.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:105:0)
[20:53:14.789] Timer tick, asking Buildbucket for the build status
[20:53:15.519] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:15.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:106:0) after 1m0s
[20:54:15.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:106:0)
[20:54:15.913] Timer tick, asking Buildbucket for the build status
[20:54:16.569] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:16.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:107:0) after 1m0s
[20:55:16.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:107:0)
[20:55:16.856] Timer tick, asking Buildbucket for the build status
[20:55:17.978] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:17.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:108:0) after 1m0s
[20:56:18.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:108:0)
[20:56:18.197] Timer tick, asking Buildbucket for the build status
[20:56:18.692] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:18.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:109:0) after 1m0s
[20:57:18.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:109:0)
[20:57:18.823] Timer tick, asking Buildbucket for the build status
[20:57:19.214] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:19.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:110:0) after 1m0s
[20:58:19.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:110:0)
[20:58:19.387] Timer tick, asking Buildbucket for the build status
[20:58:19.833] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:19.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:111:0) after 1m0s
[20:59:19.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:111:0)
[20:59:19.988] Timer tick, asking Buildbucket for the build status
[20:59:20.517] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:20.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:112:0) after 1m0s
[21:00:20.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:112:0)
[21:00:20.613] Timer tick, asking Buildbucket for the build status
[21:00:20.857] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:20.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:113:0) after 1m0s
[21:01:20.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:113:0)
[21:01:20.862] Timer tick, asking Buildbucket for the build status
[21:01:21.112] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:21.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:114:0) after 1m0s
[21:02:21.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:114:0)
[21:02:21.260] Timer tick, asking Buildbucket for the build status
[21:02:21.512] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:21.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:115:0) after 1m0s
[21:03:21.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:115:0)
[21:03:21.600] Timer tick, asking Buildbucket for the build status
[21:03:21.788] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:21.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:116:0) after 1m0s
[21:04:21.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:116:0)
[21:04:21.949] Timer tick, asking Buildbucket for the build status
[21:04:23.093] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:23.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:117:0) after 1m0s
[21:05:23.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:117:0)
[21:05:23.330] Timer tick, asking Buildbucket for the build status
[21:05:24.092] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:24.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:118:0) after 1m0s
[21:06:24.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:118:0)
[21:06:24.130] Timer tick, asking Buildbucket for the build status
[21:06:24.639] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:24.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:119:0) after 1m0s
[21:07:24.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:119:0)
[21:07:24.682] Timer tick, asking Buildbucket for the build status
[21:07:24.877] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:24.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:120:0) after 1m0s
[21:08:24.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:120:0)
[21:08:24.971] Timer tick, asking Buildbucket for the build status
[21:08:25.459] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:25.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:121:0) after 1m0s
[21:09:26.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:121:0)
[21:09:26.015] Timer tick, asking Buildbucket for the build status
[21:09:29.623] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:29.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:122:0) after 1m0s
[21:10:29.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:122:0)
[21:10:29.656] Timer tick, asking Buildbucket for the build status
[21:10:29.994] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:29.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:123:0) after 1m0s
[21:11:30.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:123:0)
[21:11:30.098] Timer tick, asking Buildbucket for the build status
[21:11:33.129] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:124:0) after 1m0s
[21:12:33.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:124:0)
[21:12:33.363] Timer tick, asking Buildbucket for the build status
[21:12:36.210] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:36.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:125:0) after 1m0s
[21:13:36.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:125:0)
[21:13:36.268] Timer tick, asking Buildbucket for the build status
[21:13:36.381] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:36.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:126:0) after 1m0s
[21:14:36.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:126:0)
[21:14:36.608] Timer tick, asking Buildbucket for the build status
[21:14:37.034] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:37.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:127:0) after 1m0s
[21:15:37.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:127:0)
[21:15:37.205] Timer tick, asking Buildbucket for the build status
[21:15:38.376] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:38.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:128:0) after 1m0s
[21:16:38.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:128:0)
[21:16:38.452] Timer tick, asking Buildbucket for the build status
[21:16:39.368] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:129:0) after 1m0s
[21:17:39.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:129:0)
[21:17:39.407] Timer tick, asking Buildbucket for the build status
[21:17:40.419] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:130:0) after 1m0s
[21:18:40.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:130:0)
[21:18:40.461] Timer tick, asking Buildbucket for the build status
[21:18:40.751] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:40.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:131:0) after 1m0s
[21:19:40.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:131:0)
[21:19:40.763] Timer tick, asking Buildbucket for the build status
[21:19:41.022] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:41.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:132:0) after 1m0s
[21:20:41.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:132:0)
[21:20:41.094] Timer tick, asking Buildbucket for the build status
[21:20:41.904] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:133:0) after 1m0s
[21:21:41.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:133:0)
[21:21:41.980] Timer tick, asking Buildbucket for the build status
[21:21:42.362] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:42.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:134:0) after 1m0s
[21:22:42.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:134:0)
[21:22:42.375] Timer tick, asking Buildbucket for the build status
[21:22:42.972] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:42.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:135:0) after 1m0s
[21:23:43.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:135:0)
[21:23:43.067] Timer tick, asking Buildbucket for the build status
[21:23:43.834] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:43.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:136:0) after 1m0s
[21:24:43.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:136:0)
[21:24:43.870] Timer tick, asking Buildbucket for the build status
[21:24:44.519] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:44.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:137:0) after 1m0s
[21:25:44.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:137:0)
[21:25:44.605] Timer tick, asking Buildbucket for the build status
[21:25:45.047] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:45.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:138:0) after 1m0s
[21:26:45.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:138:0)
[21:26:45.079] Timer tick, asking Buildbucket for the build status
[21:26:45.366] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:45.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:139:0) after 1m0s
[21:27:45.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:139:0)
[21:27:45.456] Timer tick, asking Buildbucket for the build status
[21:27:45.626] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:140:0) after 1m0s
[21:28:45.733] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:140:0)
[21:28:45.733] Timer tick, asking Buildbucket for the build status
[21:28:45.943] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:45.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:141:0) after 1m0s
[21:29:45.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:141:0)
[21:29:45.979] Timer tick, asking Buildbucket for the build status
[21:29:46.665] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:46.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:142:0) after 1m0s
[21:30:46.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:142:0)
[21:30:46.808] Timer tick, asking Buildbucket for the build status
[21:30:47.176] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:47.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:143:0) after 1m0s
[21:31:47.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:143:0)
[21:31:47.244] Timer tick, asking Buildbucket for the build status
[21:31:47.776] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:47.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:144:0) after 1m0s
[21:32:47.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:144:0)
[21:32:47.842] Timer tick, asking Buildbucket for the build status
[21:32:48.503] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:48.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:145:0) after 1m0s
[21:33:48.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:145:0)
[21:33:48.545] Timer tick, asking Buildbucket for the build status
[21:33:50.601] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:50.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:146:0) after 1m0s
[21:34:50.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:146:0)
[21:34:50.982] Timer tick, asking Buildbucket for the build status
[21:34:51.269] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:51.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:147:0) after 1m0s
[21:35:51.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:147:0)
[21:35:51.451] Timer tick, asking Buildbucket for the build status
[21:35:51.646] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:51.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:148:0) after 1m0s
[21:36:51.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:148:0)
[21:36:51.905] Timer tick, asking Buildbucket for the build status
[21:36:52.786] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:52.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:149:0) after 1m0s
[21:37:52.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:149:0)
[21:37:52.944] Timer tick, asking Buildbucket for the build status
[21:37:53.203] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:53.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:150:0) after 1m0s
[21:38:53.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:150:0)
[21:38:53.288] Timer tick, asking Buildbucket for the build status
[21:38:53.524] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:53.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:151:0) after 1m0s
[21:39:53.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:151:0)
[21:39:53.636] Timer tick, asking Buildbucket for the build status
[21:39:54.164] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:54.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:152:0) after 1m0s
[21:40:54.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:152:0)
[21:40:54.213] Timer tick, asking Buildbucket for the build status
[21:40:55.251] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:55.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:153:0) after 1m0s
[21:41:55.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:153:0)
[21:41:55.373] Timer tick, asking Buildbucket for the build status
[21:41:55.952] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:55.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:154:0) after 1m0s
[21:42:55.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:154:0)
[21:42:55.953] Timer tick, asking Buildbucket for the build status
[21:42:56.197] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:56.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:155:0) after 1m0s
[21:43:56.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:155:0)
[21:43:56.396] Timer tick, asking Buildbucket for the build status
[21:43:56.542] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:56.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:156:0) after 1m0s
[21:44:56.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:156:0)
[21:44:56.722] Timer tick, asking Buildbucket for the build status
[21:44:58.680] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:58.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:157:0) after 1m0s
[21:45:58.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:157:0)
[21:45:58.885] Timer tick, asking Buildbucket for the build status
[21:45:59.566] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:59.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:158:0) after 1m0s
[21:46:59.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:158:0)
[21:46:59.574] Timer tick, asking Buildbucket for the build status
[21:46:59.747] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:59.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:159:0) after 1m0s
[21:47:59.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:159:0)
[21:47:59.943] Timer tick, asking Buildbucket for the build status
[21:48:00.173] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:00.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:160:0) after 1m0s
[21:49:00.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:160:0)
[21:49:00.336] Timer tick, asking Buildbucket for the build status
[21:49:01.338] Build 8894342166176634464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:01.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9059772229159318912:161:0) after 1m0s
[21:49:48.972] Received PubSub notification, asking Buildbucket for the build status
[21:49:49.302] Build 8894342166176634464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[21:49:49.302] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576100987847621",
"created_by": "project:chromium",
"created_ts": "1576091336996902",
"id": "8894342166176634464",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b786fa53c5b7661c17a57ffdc96983aed0900b4\"}}",
"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-vps3\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15435, \"got_angle_revision\": \"4ad8b55ef4274c730788fe3d42e6ebc27095ca6e\", \"got_dawn_revision\": \"280b96ea8de35e145be4878ca53b6eecf7f38e67\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"5b786fa53c5b7661c17a57ffdc96983aed0900b4\", \"got_revision_cp\": \"refs/heads/master@{#723912}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"11dcf980f50784e40003a00796470406c9e7f9fb\", \"got_v8_revision\": \"87599d7029ad6d7b44af9e8a82cc737128d7713c\", \"got_v8_revision_cp\": \"refs/heads/8.1.15@{#1}\", \"got_webrtc_revision\": \"75bc75ccef59caeeeecdeac83426565efddb6780\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30064}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"5b786fa53c5b7661c17a57ffdc96983aed0900b4\"}, \"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-vps3\"], \"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\": [\"4709-f2c88b6\"], \"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": "1576091367299352",
"status": "COMPLETED",
"status_changed_ts": "1576100988349739",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15435",
"builder:Windows deterministic",
"buildset:commit/git/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/5b786fa53c5b7661c17a57ffdc96983aed0900b4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059772229159318912",
"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/8894342166176634464/+/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:490f2f17dfbad610",
"user_agent:luci-scheduler"
],
"updated_ts": "1576100988383494",
"url": "https://ci.chromium.org/b/8894342166176634464",
"utcnow_ts": "1576100989294242"
}
}
[21:49:49.302] Invocation finished in 2h40m54.534358685s with status SUCCEEDED