[23:57:38.655] New invocation is queued and will start shortly
[23:57:39.753] Starting the invocation (attempt 1)
[23:57:39.818] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:57:39.818] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:57:39.818] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027229752824766256",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"53bd3e24c5bd708f31f26c266daf5a6230b1b128\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9027229752824766256",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"gitiles_ref:refs/heads/master"
]
}
[23:57:41.340] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607126259961426",
"id": "8861799690793397840",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53bd3e24c5bd708f31f26c266daf5a6230b1b128\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607126261026376",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/17586",
"builder:Windows deterministic",
"buildset:commit/git/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027229752824766256",
"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/8861799690793397840/+/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": "1607126261026971",
"url": "https://ci.chromium.org/b/8861799690793397840",
"utcnow_ts": "1607126261324186"
}
}
[23:57:41.340] Task URL: https://ci.chromium.org/b/8861799690793397840
[23:57:41.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:2:0) after 1m0s
[23:58:41.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:2:0)
[23:58:41.364] Timer tick, asking Buildbucket for the build status
[23:58:41.497] Build 8861799690793397840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:41.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:3:0) after 1m0s
[23:59:41.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:3:0)
[23:59:41.503] Timer tick, asking Buildbucket for the build status
[23:59:41.568] Build 8861799690793397840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:41.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:4:0) after 1m0s
[23:59:44.248] Received PubSub notification, asking Buildbucket for the build status
[23:59:44.331] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:41.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:4:0)
[00:00:41.669] Timer tick, asking Buildbucket for the build status
[00:00:41.904] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:6:0) after 1m0s
[00:01:42.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:6:0)
[00:01:42.159] Timer tick, asking Buildbucket for the build status
[00:01:42.504] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:42.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:7:0) after 1m0s
[00:02:42.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:7:0)
[00:02:42.663] Timer tick, asking Buildbucket for the build status
[00:02:42.816] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:42.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:8:0) after 1m0s
[00:03:43.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:8:0)
[00:03:43.176] Timer tick, asking Buildbucket for the build status
[00:03:43.277] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:43.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:9:0) after 1m0s
[00:04:43.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:9:0)
[00:04:43.498] Timer tick, asking Buildbucket for the build status
[00:04:43.561] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:43.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:10:0) after 1m0s
[00:05:43.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:10:0)
[00:05:43.776] Timer tick, asking Buildbucket for the build status
[00:05:44.106] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:44.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:11:0) after 1m0s
[00:06:44.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:11:0)
[00:06:44.221] Timer tick, asking Buildbucket for the build status
[00:06:44.495] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:44.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:12:0) after 1m0s
[00:07:44.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:12:0)
[00:07:44.602] Timer tick, asking Buildbucket for the build status
[00:07:45.086] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:45.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:13:0) after 1m0s
[00:08:45.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:13:0)
[00:08:45.328] Timer tick, asking Buildbucket for the build status
[00:08:45.508] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:45.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:14:0) after 1m0s
[00:09:45.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:14:0)
[00:09:45.608] Timer tick, asking Buildbucket for the build status
[00:09:45.670] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:45.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:15:0) after 1m0s
[00:10:45.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:15:0)
[00:10:45.766] Timer tick, asking Buildbucket for the build status
[00:10:46.028] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:46.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:16:0) after 1m0s
[00:11:46.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:16:0)
[00:11:46.188] Timer tick, asking Buildbucket for the build status
[00:11:46.284] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:46.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:17:0) after 1m0s
[00:12:46.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:17:0)
[00:12:46.274] Timer tick, asking Buildbucket for the build status
[00:12:46.382] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:46.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:18:0) after 1m0s
[00:13:46.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:18:0)
[00:13:46.405] Timer tick, asking Buildbucket for the build status
[00:13:46.808] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:46.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:19:0) after 1m0s
[00:14:46.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:19:0)
[00:14:46.843] Timer tick, asking Buildbucket for the build status
[00:14:46.915] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:46.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:20:0) after 1m0s
[00:15:46.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:20:0)
[00:15:46.987] Timer tick, asking Buildbucket for the build status
[00:15:47.058] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:47.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:21:0) after 1m0s
[00:16:47.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:21:0)
[00:16:47.087] Timer tick, asking Buildbucket for the build status
[00:16:47.260] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:47.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:22:0) after 1m0s
[00:17:47.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:22:0)
[00:17:47.298] Timer tick, asking Buildbucket for the build status
[00:17:47.401] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:23:0) after 1m0s
[00:18:47.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:23:0)
[00:18:47.571] Timer tick, asking Buildbucket for the build status
[00:18:47.908] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:47.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:24:0) after 1m0s
[00:19:47.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:24:0)
[00:19:47.938] Timer tick, asking Buildbucket for the build status
[00:19:48.039] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:48.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:25:0) after 1m0s
[00:20:48.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:25:0)
[00:20:48.077] Timer tick, asking Buildbucket for the build status
[00:20:48.296] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:48.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:26:0) after 1m0s
[00:21:48.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:26:0)
[00:21:48.321] Timer tick, asking Buildbucket for the build status
[00:21:48.440] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:48.440] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:27:0) after 1m0s
[00:22:48.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:27:0)
[00:22:48.459] Timer tick, asking Buildbucket for the build status
[00:22:48.608] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:48.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:28:0) after 1m0s
[00:23:48.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:28:0)
[00:23:48.626] Timer tick, asking Buildbucket for the build status
[00:23:48.728] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:29:0) after 1m0s
[00:24:48.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:29:0)
[00:24:48.758] Timer tick, asking Buildbucket for the build status
[00:24:48.902] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:30:0) after 1m0s
[00:25:48.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:30:0)
[00:25:48.949] Timer tick, asking Buildbucket for the build status
[00:25:49.057] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:49.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:31:0) after 1m0s
[00:26:49.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:31:0)
[00:26:49.117] Timer tick, asking Buildbucket for the build status
[00:26:49.280] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:49.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:32:0) after 1m0s
[00:27:49.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:32:0)
[00:27:49.304] Timer tick, asking Buildbucket for the build status
[00:27:49.416] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:49.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:33:0) after 1m0s
[00:28:49.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:33:0)
[00:28:49.519] Timer tick, asking Buildbucket for the build status
[00:28:50.049] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:50.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:34:0) after 1m0s
[00:29:50.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:34:0)
[00:29:50.415] Timer tick, asking Buildbucket for the build status
[00:29:50.485] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:50.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:35:0) after 1m0s
[00:30:50.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:35:0)
[00:30:50.729] Timer tick, asking Buildbucket for the build status
[00:30:54.299] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:54.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:36:0) after 1m0s
[00:31:54.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:36:0)
[00:31:54.444] Timer tick, asking Buildbucket for the build status
[00:31:54.609] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:54.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:37:0) after 1m0s
[00:32:54.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:37:0)
[00:32:54.713] Timer tick, asking Buildbucket for the build status
[00:32:54.820] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:54.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:38:0) after 1m0s
[00:33:54.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:38:0)
[00:33:54.821] Timer tick, asking Buildbucket for the build status
[00:33:54.880] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:54.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:39:0) after 1m0s
[00:34:54.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:39:0)
[00:34:54.927] Timer tick, asking Buildbucket for the build status
[00:34:54.985] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:54.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:40:0) after 1m0s
[00:35:55.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:40:0)
[00:35:55.053] Timer tick, asking Buildbucket for the build status
[00:35:57.249] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:57.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:41:0) after 1m0s
[00:36:57.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:41:0)
[00:36:57.309] Timer tick, asking Buildbucket for the build status
[00:36:57.430] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:42:0) after 1m0s
[00:37:57.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:42:0)
[00:37:57.501] Timer tick, asking Buildbucket for the build status
[00:37:57.659] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:57.659] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:43:0) after 1m0s
[00:38:57.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:43:0)
[00:38:57.826] Timer tick, asking Buildbucket for the build status
[00:38:57.881] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:57.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:44:0) after 1m0s
[00:39:57.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:44:0)
[00:39:57.983] Timer tick, asking Buildbucket for the build status
[00:39:58.043] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:58.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:45:0) after 1m0s
[00:40:58.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:45:0)
[00:40:58.122] Timer tick, asking Buildbucket for the build status
[00:40:58.226] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:46:0) after 1m0s
[00:41:58.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:46:0)
[00:41:58.224] Timer tick, asking Buildbucket for the build status
[00:41:58.302] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:58.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:47:0) after 1m0s
[00:42:58.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:47:0)
[00:42:58.381] Timer tick, asking Buildbucket for the build status
[00:42:58.487] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:58.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:48:0) after 1m0s
[00:43:58.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:48:0)
[00:43:58.503] Timer tick, asking Buildbucket for the build status
[00:43:58.565] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:58.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:49:0) after 1m0s
[00:44:58.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:49:0)
[00:44:58.625] Timer tick, asking Buildbucket for the build status
[00:44:58.693] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:58.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:50:0) after 1m0s
[00:45:58.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:50:0)
[00:45:58.681] Timer tick, asking Buildbucket for the build status
[00:45:58.737] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:58.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:51:0) after 1m0s
[00:46:58.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:51:0)
[00:46:58.789] Timer tick, asking Buildbucket for the build status
[00:46:59.009] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:59.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:52:0) after 1m0s
[00:47:59.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:52:0)
[00:47:59.056] Timer tick, asking Buildbucket for the build status
[00:47:59.274] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:59.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:53:0) after 1m0s
[00:48:59.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:53:0)
[00:48:59.299] Timer tick, asking Buildbucket for the build status
[00:48:59.381] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:59.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:54:0) after 1m0s
[00:49:59.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:54:0)
[00:49:59.434] Timer tick, asking Buildbucket for the build status
[00:49:59.523] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:59.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:55:0) after 1m0s
[00:50:59.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:55:0)
[00:50:59.590] Timer tick, asking Buildbucket for the build status
[00:50:59.887] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:59.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:56:0) after 1m0s
[00:51:59.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:56:0)
[00:51:59.946] Timer tick, asking Buildbucket for the build status
[00:52:00.257] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:00.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:57:0) after 1m0s
[00:53:00.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:57:0)
[00:53:00.331] Timer tick, asking Buildbucket for the build status
[00:53:00.501] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:00.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:58:0) after 1m0s
[00:54:00.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:58:0)
[00:54:00.584] Timer tick, asking Buildbucket for the build status
[00:54:00.715] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:00.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:59:0) after 1m0s
[00:55:00.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:59:0)
[00:55:00.751] Timer tick, asking Buildbucket for the build status
[00:55:01.203] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:01.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:60:0) after 1m0s
[00:56:01.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:60:0)
[00:56:01.252] Timer tick, asking Buildbucket for the build status
[00:56:01.924] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:01.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:61:0) after 1m0s
[00:57:01.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:61:0)
[00:57:01.959] Timer tick, asking Buildbucket for the build status
[00:57:02.093] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:02.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:62:0) after 1m0s
[00:58:02.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:62:0)
[00:58:02.119] Timer tick, asking Buildbucket for the build status
[00:58:02.319] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:02.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:63:0) after 1m0s
[00:59:02.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:63:0)
[00:59:02.493] Timer tick, asking Buildbucket for the build status
[00:59:02.603] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:02.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:64:0) after 1m0s
[01:00:02.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:64:0)
[01:00:02.720] Timer tick, asking Buildbucket for the build status
[01:00:02.966] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:02.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:65:0) after 1m0s
[01:01:03.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:65:0)
[01:01:03.043] Timer tick, asking Buildbucket for the build status
[01:01:03.374] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:03.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:66:0) after 1m0s
[01:02:03.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:66:0)
[01:02:03.527] Timer tick, asking Buildbucket for the build status
[01:02:04.120] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:04.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:67:0) after 1m0s
[01:03:04.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:67:0)
[01:03:04.221] Timer tick, asking Buildbucket for the build status
[01:03:04.368] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:04.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:68:0) after 1m0s
[01:04:04.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:68:0)
[01:04:04.481] Timer tick, asking Buildbucket for the build status
[01:04:04.891] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:04.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:69:0) after 1m0s
[01:05:04.941] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:69:0)
[01:05:04.941] Timer tick, asking Buildbucket for the build status
[01:05:05.017] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:05.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:70:0) after 1m0s
[01:06:05.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:70:0)
[01:06:05.074] Timer tick, asking Buildbucket for the build status
[01:06:05.946] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:05.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:71:0) after 1m0s
[01:07:05.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:71:0)
[01:07:05.985] Timer tick, asking Buildbucket for the build status
[01:07:06.117] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:06.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:72:0) after 1m0s
[01:08:06.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:72:0)
[01:08:06.294] Timer tick, asking Buildbucket for the build status
[01:08:06.420] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:06.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:73:0) after 1m0s
[01:09:06.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:73:0)
[01:09:06.486] Timer tick, asking Buildbucket for the build status
[01:09:06.712] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:06.712] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:74:0) after 1m0s
[01:10:06.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:74:0)
[01:10:06.942] Timer tick, asking Buildbucket for the build status
[01:10:07.105] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:07.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:75:0) after 1m0s
[01:11:07.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:75:0)
[01:11:07.390] Timer tick, asking Buildbucket for the build status
[01:11:08.213] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:08.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:76:0) after 1m0s
[01:12:08.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:76:0)
[01:12:08.407] Timer tick, asking Buildbucket for the build status
[01:12:08.753] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:08.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:77:0) after 1m0s
[01:13:08.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:77:0)
[01:13:08.872] Timer tick, asking Buildbucket for the build status
[01:13:09.398] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:09.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:78:0) after 1m0s
[01:14:09.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:78:0)
[01:14:09.509] Timer tick, asking Buildbucket for the build status
[01:14:10.233] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:10.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:79:0) after 1m0s
[01:15:10.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:79:0)
[01:15:10.269] Timer tick, asking Buildbucket for the build status
[01:15:10.547] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:10.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:80:0) after 1m0s
[01:16:10.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:80:0)
[01:16:10.731] Timer tick, asking Buildbucket for the build status
[01:16:11.124] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:11.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:81:0) after 1m0s
[01:17:11.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:81:0)
[01:17:11.278] Timer tick, asking Buildbucket for the build status
[01:17:11.345] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:11.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:82:0) after 1m0s
[01:18:11.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:82:0)
[01:18:11.438] Timer tick, asking Buildbucket for the build status
[01:18:11.603] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:11.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:83:0) after 1m0s
[01:19:11.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:83:0)
[01:19:11.723] Timer tick, asking Buildbucket for the build status
[01:19:11.803] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:11.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:84:0) after 1m0s
[01:20:11.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:84:0)
[01:20:11.873] Timer tick, asking Buildbucket for the build status
[01:20:12.031] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:12.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:85:0) after 1m0s
[01:21:12.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:85:0)
[01:21:12.075] Timer tick, asking Buildbucket for the build status
[01:21:12.259] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:12.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:86:0) after 1m0s
[01:22:12.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:86:0)
[01:22:12.287] Timer tick, asking Buildbucket for the build status
[01:22:12.464] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:12.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:87:0) after 1m0s
[01:23:12.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:87:0)
[01:23:12.450] Timer tick, asking Buildbucket for the build status
[01:23:13.455] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:13.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:88:0) after 1m0s
[01:24:13.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:88:0)
[01:24:13.519] Timer tick, asking Buildbucket for the build status
[01:24:13.592] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:13.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:89:0) after 1m0s
[01:25:13.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:89:0)
[01:25:13.688] Timer tick, asking Buildbucket for the build status
[01:25:13.946] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:13.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:90:0) after 1m0s
[01:26:14.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:90:0)
[01:26:14.025] Timer tick, asking Buildbucket for the build status
[01:26:14.104] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:14.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:91:0) after 1m0s
[01:27:14.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:91:0)
[01:27:14.195] Timer tick, asking Buildbucket for the build status
[01:27:14.401] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:14.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:92:0) after 1m0s
[01:28:14.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:92:0)
[01:28:14.415] Timer tick, asking Buildbucket for the build status
[01:28:14.555] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:14.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:93:0) after 1m0s
[01:29:14.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:93:0)
[01:29:14.592] Timer tick, asking Buildbucket for the build status
[01:29:14.806] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:14.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:94:0) after 1m0s
[01:30:14.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:94:0)
[01:30:14.916] Timer tick, asking Buildbucket for the build status
[01:30:15.168] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:15.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:95:0) after 1m0s
[01:31:15.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:95:0)
[01:31:15.237] Timer tick, asking Buildbucket for the build status
[01:31:15.495] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:15.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:96:0) after 1m0s
[01:32:15.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:96:0)
[01:32:15.617] Timer tick, asking Buildbucket for the build status
[01:32:15.745] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:97:0) after 1m0s
[01:33:15.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:97:0)
[01:33:15.931] Timer tick, asking Buildbucket for the build status
[01:33:16.053] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:16.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:98:0) after 1m0s
[01:34:16.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:98:0)
[01:34:16.109] Timer tick, asking Buildbucket for the build status
[01:34:16.188] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:99:0) after 1m0s
[01:35:16.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:99:0)
[01:35:16.288] Timer tick, asking Buildbucket for the build status
[01:35:16.380] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:16.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:100:0) after 1m0s
[01:36:16.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:100:0)
[01:36:16.418] Timer tick, asking Buildbucket for the build status
[01:36:16.681] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:16.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:101:0) after 1m0s
[01:37:16.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:101:0)
[01:37:16.763] Timer tick, asking Buildbucket for the build status
[01:37:16.846] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:16.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:102:0) after 1m0s
[01:38:16.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:102:0)
[01:38:16.909] Timer tick, asking Buildbucket for the build status
[01:38:17.045] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:17.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:103:0) after 1m0s
[01:39:17.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:103:0)
[01:39:17.152] Timer tick, asking Buildbucket for the build status
[01:39:17.218] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:17.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:104:0) after 1m0s
[01:40:17.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:104:0)
[01:40:17.378] Timer tick, asking Buildbucket for the build status
[01:40:17.451] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:17.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:105:0) after 1m0s
[01:41:17.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:105:0)
[01:41:17.547] Timer tick, asking Buildbucket for the build status
[01:41:17.601] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:17.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:106:0) after 1m0s
[01:42:17.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:106:0)
[01:42:17.664] Timer tick, asking Buildbucket for the build status
[01:42:17.754] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:17.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:107:0) after 1m0s
[01:43:17.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:107:0)
[01:43:17.818] Timer tick, asking Buildbucket for the build status
[01:43:17.926] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:17.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:108:0) after 1m0s
[01:44:18.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:108:0)
[01:44:18.006] Timer tick, asking Buildbucket for the build status
[01:44:18.072] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:18.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:109:0) after 1m0s
[01:45:18.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:109:0)
[01:45:18.395] Timer tick, asking Buildbucket for the build status
[01:45:18.730] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:18.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:110:0) after 1m0s
[01:46:18.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:110:0)
[01:46:18.779] Timer tick, asking Buildbucket for the build status
[01:46:18.865] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:18.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:111:0) after 1m0s
[01:47:18.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:111:0)
[01:47:18.912] Timer tick, asking Buildbucket for the build status
[01:47:19.067] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:19.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:112:0) after 1m0s
[01:48:19.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:112:0)
[01:48:19.143] Timer tick, asking Buildbucket for the build status
[01:48:19.252] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:19.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:113:0) after 1m0s
[01:49:19.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:113:0)
[01:49:19.279] Timer tick, asking Buildbucket for the build status
[01:49:19.385] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:19.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:114:0) after 1m0s
[01:50:19.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:114:0)
[01:50:19.455] Timer tick, asking Buildbucket for the build status
[01:50:19.544] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:19.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:115:0) after 1m0s
[01:51:19.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:115:0)
[01:51:19.616] Timer tick, asking Buildbucket for the build status
[01:51:19.684] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:19.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:116:0) after 1m0s
[01:52:19.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:116:0)
[01:52:19.755] Timer tick, asking Buildbucket for the build status
[01:52:19.837] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:19.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:117:0) after 1m0s
[01:53:19.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:117:0)
[01:53:19.882] Timer tick, asking Buildbucket for the build status
[01:53:20.065] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:20.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:118:0) after 1m0s
[01:54:20.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:118:0)
[01:54:20.149] Timer tick, asking Buildbucket for the build status
[01:54:20.536] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:20.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:119:0) after 1m0s
[01:55:20.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:119:0)
[01:55:20.670] Timer tick, asking Buildbucket for the build status
[01:55:20.874] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:20.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:120:0) after 1m0s
[01:56:20.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:120:0)
[01:56:20.946] Timer tick, asking Buildbucket for the build status
[01:56:21.293] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:21.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:121:0) after 1m0s
[01:57:21.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:121:0)
[01:57:21.384] Timer tick, asking Buildbucket for the build status
[01:57:21.588] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:21.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:122:0) after 1m0s
[01:58:21.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:122:0)
[01:58:21.626] Timer tick, asking Buildbucket for the build status
[01:58:21.739] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:21.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:123:0) after 1m0s
[01:59:21.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:123:0)
[01:59:21.784] Timer tick, asking Buildbucket for the build status
[01:59:21.867] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:21.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:124:0) after 1m0s
[02:00:21.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:124:0)
[02:00:21.943] Timer tick, asking Buildbucket for the build status
[02:00:22.607] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:22.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:125:0) after 1m0s
[02:01:22.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:125:0)
[02:01:22.737] Timer tick, asking Buildbucket for the build status
[02:01:22.835] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:22.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:126:0) after 1m0s
[02:02:23.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:126:0)
[02:02:23.015] Timer tick, asking Buildbucket for the build status
[02:02:23.095] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:23.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:127:0) after 1m0s
[02:03:23.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:127:0)
[02:03:23.103] Timer tick, asking Buildbucket for the build status
[02:03:23.285] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:23.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:128:0) after 1m0s
[02:04:23.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:128:0)
[02:04:23.413] Timer tick, asking Buildbucket for the build status
[02:04:23.635] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:23.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:129:0) after 1m0s
[02:05:23.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:129:0)
[02:05:23.791] Timer tick, asking Buildbucket for the build status
[02:05:24.023] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:24.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:130:0) after 1m0s
[02:06:24.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:130:0)
[02:06:24.058] Timer tick, asking Buildbucket for the build status
[02:06:24.159] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:24.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:131:0) after 1m0s
[02:07:24.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:131:0)
[02:07:24.213] Timer tick, asking Buildbucket for the build status
[02:07:24.281] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:24.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:132:0) after 1m0s
[02:08:24.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:132:0)
[02:08:24.328] Timer tick, asking Buildbucket for the build status
[02:08:24.470] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:24.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:133:0) after 1m0s
[02:09:24.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:133:0)
[02:09:24.478] Timer tick, asking Buildbucket for the build status
[02:09:24.572] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:24.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:134:0) after 1m0s
[02:10:24.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:134:0)
[02:10:24.642] Timer tick, asking Buildbucket for the build status
[02:10:24.969] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:24.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:135:0) after 1m0s
[02:11:25.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:135:0)
[02:11:25.069] Timer tick, asking Buildbucket for the build status
[02:11:25.144] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:25.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:136:0) after 1m0s
[02:12:25.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:136:0)
[02:12:25.137] Timer tick, asking Buildbucket for the build status
[02:12:25.288] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:25.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:137:0) after 1m0s
[02:13:25.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:137:0)
[02:13:25.403] Timer tick, asking Buildbucket for the build status
[02:13:25.583] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:25.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:138:0) after 1m0s
[02:14:25.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:138:0)
[02:14:25.729] Timer tick, asking Buildbucket for the build status
[02:14:25.834] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:139:0) after 1m0s
[02:15:25.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:139:0)
[02:15:25.940] Timer tick, asking Buildbucket for the build status
[02:15:26.088] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:26.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:140:0) after 1m0s
[02:16:26.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:140:0)
[02:16:26.162] Timer tick, asking Buildbucket for the build status
[02:16:26.345] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:26.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:141:0) after 1m0s
[02:17:26.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:141:0)
[02:17:26.371] Timer tick, asking Buildbucket for the build status
[02:17:26.499] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:26.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:142:0) after 1m0s
[02:18:26.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:142:0)
[02:18:26.528] Timer tick, asking Buildbucket for the build status
[02:18:26.654] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:26.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:143:0) after 1m0s
[02:19:26.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:143:0)
[02:19:26.821] Timer tick, asking Buildbucket for the build status
[02:19:27.015] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:27.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:144:0) after 1m0s
[02:20:27.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:144:0)
[02:20:27.083] Timer tick, asking Buildbucket for the build status
[02:20:27.492] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:27.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:145:0) after 1m0s
[02:21:27.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:145:0)
[02:21:27.517] Timer tick, asking Buildbucket for the build status
[02:21:27.589] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:27.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:146:0) after 1m0s
[02:22:27.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:146:0)
[02:22:27.623] Timer tick, asking Buildbucket for the build status
[02:22:27.693] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:27.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:147:0) after 1m0s
[02:23:27.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:147:0)
[02:23:27.759] Timer tick, asking Buildbucket for the build status
[02:23:27.883] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:27.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:148:0) after 1m0s
[02:24:27.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:148:0)
[02:24:27.968] Timer tick, asking Buildbucket for the build status
[02:24:28.039] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:28.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:149:0) after 1m0s
[02:25:28.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:149:0)
[02:25:28.183] Timer tick, asking Buildbucket for the build status
[02:25:28.284] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:28.284] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:150:0) after 1m0s
[02:26:28.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:150:0)
[02:26:28.343] Timer tick, asking Buildbucket for the build status
[02:26:28.451] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:28.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:151:0) after 1m0s
[02:27:28.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:151:0)
[02:27:28.676] Timer tick, asking Buildbucket for the build status
[02:27:28.795] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:28.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:152:0) after 1m0s
[02:28:29.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:152:0)
[02:28:29.024] Timer tick, asking Buildbucket for the build status
[02:28:29.295] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:153:0) after 1m0s
[02:29:29.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:153:0)
[02:29:29.369] Timer tick, asking Buildbucket for the build status
[02:29:29.462] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:29.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:154:0) after 1m0s
[02:30:29.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:154:0)
[02:30:29.714] Timer tick, asking Buildbucket for the build status
[02:30:29.842] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:155:0) after 1m0s
[02:31:29.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:155:0)
[02:31:29.979] Timer tick, asking Buildbucket for the build status
[02:31:30.269] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:156:0) after 1m0s
[02:32:30.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:156:0)
[02:32:30.367] Timer tick, asking Buildbucket for the build status
[02:32:30.444] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:30.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:157:0) after 1m0s
[02:33:30.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:157:0)
[02:33:30.584] Timer tick, asking Buildbucket for the build status
[02:33:30.705] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:30.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:158:0) after 1m0s
[02:34:30.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:158:0)
[02:34:30.841] Timer tick, asking Buildbucket for the build status
[02:34:30.912] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:30.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:159:0) after 1m0s
[02:35:30.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:159:0)
[02:35:30.929] Timer tick, asking Buildbucket for the build status
[02:35:30.986] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:30.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:160:0) after 1m0s
[02:36:31.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:160:0)
[02:36:31.048] Timer tick, asking Buildbucket for the build status
[02:36:31.134] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:31.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:161:0) after 1m0s
[02:37:31.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:161:0)
[02:37:31.259] Timer tick, asking Buildbucket for the build status
[02:37:31.572] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:31.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:162:0) after 1m0s
[02:38:31.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:162:0)
[02:38:31.567] Timer tick, asking Buildbucket for the build status
[02:38:31.687] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:31.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:163:0) after 1m0s
[02:39:31.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:163:0)
[02:39:31.782] Timer tick, asking Buildbucket for the build status
[02:39:31.850] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:31.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:164:0) after 1m0s
[02:40:31.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:164:0)
[02:40:31.973] Timer tick, asking Buildbucket for the build status
[02:40:32.046] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:32.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:165:0) after 1m0s
[02:41:32.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:165:0)
[02:41:32.137] Timer tick, asking Buildbucket for the build status
[02:41:32.218] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:32.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:166:0) after 1m0s
[02:42:32.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:166:0)
[02:42:32.289] Timer tick, asking Buildbucket for the build status
[02:42:32.407] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:32.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:167:0) after 1m0s
[02:43:32.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:167:0)
[02:43:32.473] Timer tick, asking Buildbucket for the build status
[02:43:32.596] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:32.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:168:0) after 1m0s
[02:44:32.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:168:0)
[02:44:32.714] Timer tick, asking Buildbucket for the build status
[02:44:32.811] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:32.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:169:0) after 1m0s
[02:45:32.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:169:0)
[02:45:32.843] Timer tick, asking Buildbucket for the build status
[02:45:32.915] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:32.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:170:0) after 1m0s
[02:46:32.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:170:0)
[02:46:32.930] Timer tick, asking Buildbucket for the build status
[02:46:33.006] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:33.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:171:0) after 1m0s
[02:47:33.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:171:0)
[02:47:33.074] Timer tick, asking Buildbucket for the build status
[02:47:33.164] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:33.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:172:0) after 1m0s
[02:48:33.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:172:0)
[02:48:33.235] Timer tick, asking Buildbucket for the build status
[02:48:33.504] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:33.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:173:0) after 1m0s
[02:49:33.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:173:0)
[02:49:33.502] Timer tick, asking Buildbucket for the build status
[02:49:34.844] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:34.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:174:0) after 1m0s
[02:50:34.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:174:0)
[02:50:34.901] Timer tick, asking Buildbucket for the build status
[02:50:35.195] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:35.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:175:0) after 1m0s
[02:51:35.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:175:0)
[02:51:35.249] Timer tick, asking Buildbucket for the build status
[02:51:35.340] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:35.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:176:0) after 1m0s
[02:52:35.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:176:0)
[02:52:35.415] Timer tick, asking Buildbucket for the build status
[02:52:35.569] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:35.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:177:0) after 1m0s
[02:53:35.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:177:0)
[02:53:35.609] Timer tick, asking Buildbucket for the build status
[02:53:35.939] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:35.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:178:0) after 1m0s
[02:54:36.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:178:0)
[02:54:36.029] Timer tick, asking Buildbucket for the build status
[02:54:36.242] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:36.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:179:0) after 1m0s
[02:55:36.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:179:0)
[02:55:36.236] Timer tick, asking Buildbucket for the build status
[02:55:36.307] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:36.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:180:0) after 1m0s
[02:56:36.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:180:0)
[02:56:36.364] Timer tick, asking Buildbucket for the build status
[02:56:36.442] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:36.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:181:0) after 1m0s
[02:57:36.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:181:0)
[02:57:36.474] Timer tick, asking Buildbucket for the build status
[02:57:36.535] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:36.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:182:0) after 1m0s
[02:58:36.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:182:0)
[02:58:36.576] Timer tick, asking Buildbucket for the build status
[02:58:36.888] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:36.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:183:0) after 1m0s
[02:59:36.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:183:0)
[02:59:36.922] Timer tick, asking Buildbucket for the build status
[02:59:37.167] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:37.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:184:0) after 1m0s
[03:00:37.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:184:0)
[03:00:37.176] Timer tick, asking Buildbucket for the build status
[03:00:37.382] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:37.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:185:0) after 1m0s
[03:01:37.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:185:0)
[03:01:37.409] Timer tick, asking Buildbucket for the build status
[03:01:37.476] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:37.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:186:0) after 1m0s
[03:02:37.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:186:0)
[03:02:37.502] Timer tick, asking Buildbucket for the build status
[03:02:37.739] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:37.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:187:0) after 1m0s
[03:03:37.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:187:0)
[03:03:37.820] Timer tick, asking Buildbucket for the build status
[03:03:38.289] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:38.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:188:0) after 1m0s
[03:04:38.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:188:0)
[03:04:38.290] Timer tick, asking Buildbucket for the build status
[03:04:38.534] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:38.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:189:0) after 1m0s
[03:05:38.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:189:0)
[03:05:38.560] Timer tick, asking Buildbucket for the build status
[03:05:38.644] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:38.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:190:0) after 1m0s
[03:06:38.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:190:0)
[03:06:38.750] Timer tick, asking Buildbucket for the build status
[03:06:38.821] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:38.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:191:0) after 1m0s
[03:07:38.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:191:0)
[03:07:38.851] Timer tick, asking Buildbucket for the build status
[03:07:38.925] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:38.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:192:0) after 1m0s
[03:08:38.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:192:0)
[03:08:38.956] Timer tick, asking Buildbucket for the build status
[03:08:39.072] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:39.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:193:0) after 1m0s
[03:09:39.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:193:0)
[03:09:39.102] Timer tick, asking Buildbucket for the build status
[03:09:39.261] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:39.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:194:0) after 1m0s
[03:10:39.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:194:0)
[03:10:39.297] Timer tick, asking Buildbucket for the build status
[03:10:40.273] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:40.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:195:0) after 1m0s
[03:11:40.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:195:0)
[03:11:40.356] Timer tick, asking Buildbucket for the build status
[03:11:40.464] Build 8861799690793397840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:40.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9027229752824766256:196:0) after 1m0s
[03:12:40.575] Received PubSub notification, asking Buildbucket for the build status
[03:12:40.665] Build 8861799690793397840: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:12:40.665] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607137960160882",
"created_by": "project:chromium",
"created_ts": "1607126259961426",
"failure_reason": "BUILD_FAILURE",
"id": "8861799690793397840",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53bd3e24c5bd708f31f26c266daf5a6230b1b128\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _Second build_ failed. Error logs are shown below:\\n```\\n[106504/106553] LINK browser_tests.exe browser_tests.exe.pdb\\nFAILED: browser_tests.exe browser_tests.exe.pdb\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 150.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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-zzou\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.win\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 17586, \"got_angle_revision\": \"f42409e60211e9952d01918834c0eace3aeb27fd\", \"got_dawn_revision\": \"c532048062befdee8bb57d18f01d3a3c403d49de\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"53bd3e24c5bd708f31f26c266daf5a6230b1b128\", \"got_revision_cp\": \"refs/heads/master@{#833933}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"53bd3e24c5bd708f31f26c266daf5a6230b1b128\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-zzou\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}, \"ui\": {\"info\": \"#### Step _Second build_ failed. Error logs are shown below:\\n```\\n[106504/106553] LINK browser_tests.exe browser_tests.exe.pdb\\nFAILED: browser_tests.exe browser_tests.exe.pdb\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607126383464287",
"status": "COMPLETED",
"status_changed_ts": "1607126383854418",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/17586",
"builder:Windows deterministic",
"buildset:commit/git/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/53bd3e24c5bd708f31f26c266daf5a6230b1b128",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027229752824766256",
"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/8861799690793397840/+/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:504902266b618410",
"user_agent:luci-scheduler"
],
"updated_ts": "1607137960227415",
"url": "https://ci.chromium.org/b/8861799690793397840",
"utcnow_ts": "1607137960649568"
}
}
[03:12:40.665] Invocation finished in 3h15m2.025649596s with status FAILED