[08:47:34.453] New invocation is queued and will start shortly
[08:47:35.779] Starting the invocation (attempt 1)
[08:47:35.817] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:47:35.818] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:47:35.818] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9045225208830281328",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9045225208830281328",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"gitiles_ref:refs/heads/master"
]
}
[08:47:36.519] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1589964455898608",
"id": "8879795146650280832",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589964456328765",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16528",
"builder:Windows deterministic",
"buildset:commit/git/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045225208830281328",
"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/8879795146650280832/+/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": "1589964456328883",
"url": "https://ci.chromium.org/b/8879795146650280832",
"utcnow_ts": "1589964456507259"
}
}
[08:47:36.519] Task URL: https://ci.chromium.org/b/8879795146650280832
[08:47:36.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:2:0) after 1m0s
[08:48:36.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:2:0)
[08:48:36.625] Timer tick, asking Buildbucket for the build status
[08:48:37.225] Build 8879795146650280832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:48:37.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:3:0) after 1m0s
[08:49:37.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:3:0)
[08:49:37.502] Timer tick, asking Buildbucket for the build status
[08:49:37.674] Build 8879795146650280832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:49:37.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:4:0) after 1m0s
[08:50:37.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:4:0)
[08:50:37.743] Timer tick, asking Buildbucket for the build status
[08:50:38.584] Build 8879795146650280832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:50:38.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:5:0) after 1m0s
[08:51:38.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:5:0)
[08:51:38.851] Timer tick, asking Buildbucket for the build status
[08:51:39.204] Build 8879795146650280832: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:51:39.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:6:0) after 1m0s
[08:52:36.301] Received PubSub notification, asking Buildbucket for the build status
[08:52:36.380] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:39.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:6:0)
[08:52:39.337] Timer tick, asking Buildbucket for the build status
[08:52:39.890] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:39.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:8:0) after 1m0s
[08:53:39.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:8:0)
[08:53:39.910] Timer tick, asking Buildbucket for the build status
[08:53:40.093] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:40.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:9:0) after 1m0s
[08:54:40.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:9:0)
[08:54:40.073] Timer tick, asking Buildbucket for the build status
[08:54:40.230] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:40.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:10:0) after 1m0s
[08:55:40.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:10:0)
[08:55:40.300] Timer tick, asking Buildbucket for the build status
[08:55:42.512] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:42.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:11:0) after 1m0s
[08:56:42.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:11:0)
[08:56:42.605] Timer tick, asking Buildbucket for the build status
[08:56:42.893] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:42.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:12:0) after 1m0s
[08:57:42.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:12:0)
[08:57:42.914] Timer tick, asking Buildbucket for the build status
[08:57:44.191] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:44.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:13:0) after 1m0s
[08:58:44.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:13:0)
[08:58:44.337] Timer tick, asking Buildbucket for the build status
[08:58:44.493] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:44.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:14:0) after 1m0s
[08:59:44.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:14:0)
[08:59:44.535] Timer tick, asking Buildbucket for the build status
[08:59:44.663] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:44.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:15:0) after 1m0s
[09:00:44.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:15:0)
[09:00:44.717] Timer tick, asking Buildbucket for the build status
[09:00:45.028] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:45.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:16:0) after 1m0s
[09:01:45.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:16:0)
[09:01:45.351] Timer tick, asking Buildbucket for the build status
[09:01:47.237] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:47.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:17:0) after 1m0s
[09:02:47.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:17:0)
[09:02:47.271] Timer tick, asking Buildbucket for the build status
[09:02:47.599] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:47.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:18:0) after 1m0s
[09:03:47.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:18:0)
[09:03:47.673] Timer tick, asking Buildbucket for the build status
[09:03:47.863] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:47.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:19:0) after 1m0s
[09:04:47.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:19:0)
[09:04:47.966] Timer tick, asking Buildbucket for the build status
[09:04:48.101] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:48.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:20:0) after 1m0s
[09:05:48.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:20:0)
[09:05:48.216] Timer tick, asking Buildbucket for the build status
[09:05:48.611] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:48.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:21:0) after 1m0s
[09:06:48.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:21:0)
[09:06:48.646] Timer tick, asking Buildbucket for the build status
[09:06:48.854] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:48.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:22:0) after 1m0s
[09:07:48.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:22:0)
[09:07:48.935] Timer tick, asking Buildbucket for the build status
[09:07:49.052] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:49.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:23:0) after 1m0s
[09:08:49.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:23:0)
[09:08:49.083] Timer tick, asking Buildbucket for the build status
[09:08:49.207] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:49.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:24:0) after 1m0s
[09:09:49.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:24:0)
[09:09:49.261] Timer tick, asking Buildbucket for the build status
[09:09:49.652] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:49.652] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:25:0) after 1m0s
[09:10:49.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:25:0)
[09:10:49.676] Timer tick, asking Buildbucket for the build status
[09:10:50.360] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:50.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:26:0) after 1m0s
[09:11:50.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:26:0)
[09:11:50.380] Timer tick, asking Buildbucket for the build status
[09:11:50.482] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:50.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:27:0) after 1m0s
[09:12:50.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:27:0)
[09:12:50.611] Timer tick, asking Buildbucket for the build status
[09:12:50.933] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:50.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:28:0) after 1m0s
[09:13:50.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:28:0)
[09:13:50.978] Timer tick, asking Buildbucket for the build status
[09:13:51.172] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:51.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:29:0) after 1m0s
[09:14:51.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:29:0)
[09:14:51.214] Timer tick, asking Buildbucket for the build status
[09:14:51.394] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:51.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:30:0) after 1m0s
[09:15:51.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:30:0)
[09:15:51.431] Timer tick, asking Buildbucket for the build status
[09:15:51.639] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:51.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:31:0) after 1m0s
[09:16:51.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:31:0)
[09:16:51.819] Timer tick, asking Buildbucket for the build status
[09:16:52.106] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:52.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:32:0) after 1m0s
[09:17:52.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:32:0)
[09:17:52.217] Timer tick, asking Buildbucket for the build status
[09:17:52.460] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:52.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:33:0) after 1m0s
[09:18:52.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:33:0)
[09:18:52.794] Timer tick, asking Buildbucket for the build status
[09:18:52.945] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:52.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:34:0) after 1m0s
[09:19:53.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:34:0)
[09:19:53.064] Timer tick, asking Buildbucket for the build status
[09:19:53.247] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:53.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:35:0) after 1m0s
[09:20:53.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:35:0)
[09:20:53.307] Timer tick, asking Buildbucket for the build status
[09:20:53.622] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:53.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:36:0) after 1m0s
[09:21:53.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:36:0)
[09:21:53.688] Timer tick, asking Buildbucket for the build status
[09:21:53.892] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:53.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:37:0) after 1m0s
[09:22:53.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:37:0)
[09:22:53.912] Timer tick, asking Buildbucket for the build status
[09:22:54.055] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:54.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:38:0) after 1m0s
[09:23:54.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:38:0)
[09:23:54.062] Timer tick, asking Buildbucket for the build status
[09:23:54.335] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:54.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:39:0) after 1m0s
[09:24:54.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:39:0)
[09:24:54.851] Timer tick, asking Buildbucket for the build status
[09:24:55.628] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:55.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:40:0) after 1m0s
[09:25:55.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:40:0)
[09:25:55.650] Timer tick, asking Buildbucket for the build status
[09:25:56.286] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:56.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:41:0) after 1m0s
[09:26:56.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:41:0)
[09:26:56.429] Timer tick, asking Buildbucket for the build status
[09:26:56.589] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:56.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:42:0) after 1m0s
[09:27:56.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:42:0)
[09:27:56.670] Timer tick, asking Buildbucket for the build status
[09:27:56.805] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:56.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:43:0) after 1m0s
[09:28:56.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:43:0)
[09:28:56.897] Timer tick, asking Buildbucket for the build status
[09:28:57.280] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:57.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:44:0) after 1m0s
[09:29:57.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:44:0)
[09:29:57.492] Timer tick, asking Buildbucket for the build status
[09:29:57.707] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:57.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:45:0) after 1m0s
[09:30:57.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:45:0)
[09:30:57.963] Timer tick, asking Buildbucket for the build status
[09:30:58.172] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:58.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:46:0) after 1m0s
[09:31:58.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:46:0)
[09:31:58.366] Timer tick, asking Buildbucket for the build status
[09:31:58.583] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:58.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:47:0) after 1m0s
[09:32:58.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:47:0)
[09:32:58.812] Timer tick, asking Buildbucket for the build status
[09:32:58.995] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:58.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:48:0) after 1m0s
[09:33:59.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:48:0)
[09:33:59.185] Timer tick, asking Buildbucket for the build status
[09:33:59.327] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:59.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:49:0) after 1m0s
[09:34:59.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:49:0)
[09:34:59.407] Timer tick, asking Buildbucket for the build status
[09:34:59.639] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:59.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:50:0) after 1m0s
[09:35:59.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:50:0)
[09:35:59.671] Timer tick, asking Buildbucket for the build status
[09:35:59.848] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:59.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:51:0) after 1m0s
[09:36:59.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:51:0)
[09:36:59.878] Timer tick, asking Buildbucket for the build status
[09:36:59.989] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:59.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:52:0) after 1m0s
[09:38:00.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:52:0)
[09:38:00.068] Timer tick, asking Buildbucket for the build status
[09:38:00.445] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:00.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:53:0) after 1m0s
[09:39:01.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:53:0)
[09:39:01.076] Timer tick, asking Buildbucket for the build status
[09:39:01.227] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:01.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:54:0) after 1m0s
[09:40:01.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:54:0)
[09:40:01.758] Timer tick, asking Buildbucket for the build status
[09:40:01.899] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:01.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:55:0) after 1m0s
[09:41:02.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:55:0)
[09:41:02.356] Timer tick, asking Buildbucket for the build status
[09:41:02.549] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:02.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:56:0) after 1m0s
[09:42:02.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:56:0)
[09:42:02.662] Timer tick, asking Buildbucket for the build status
[09:42:03.040] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:03.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:57:0) after 1m0s
[09:43:03.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:57:0)
[09:43:03.093] Timer tick, asking Buildbucket for the build status
[09:43:03.207] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:03.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:58:0) after 1m0s
[09:44:03.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:58:0)
[09:44:03.284] Timer tick, asking Buildbucket for the build status
[09:44:03.422] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:03.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:59:0) after 1m0s
[09:45:03.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:59:0)
[09:45:03.590] Timer tick, asking Buildbucket for the build status
[09:45:04.406] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:04.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:60:0) after 1m0s
[09:46:04.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:60:0)
[09:46:04.583] Timer tick, asking Buildbucket for the build status
[09:46:04.704] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:04.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:61:0) after 1m0s
[09:47:04.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:61:0)
[09:47:04.957] Timer tick, asking Buildbucket for the build status
[09:47:05.206] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:05.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:62:0) after 1m0s
[09:48:05.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:62:0)
[09:48:05.499] Timer tick, asking Buildbucket for the build status
[09:48:05.640] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:05.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:63:0) after 1m0s
[09:49:05.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:63:0)
[09:49:05.753] Timer tick, asking Buildbucket for the build status
[09:49:05.920] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:05.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:64:0) after 1m0s
[09:50:06.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:64:0)
[09:50:06.036] Timer tick, asking Buildbucket for the build status
[09:50:06.208] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:06.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:65:0) after 1m0s
[09:51:06.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:65:0)
[09:51:06.205] Timer tick, asking Buildbucket for the build status
[09:51:06.344] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:06.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:66:0) after 1m0s
[09:52:06.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:66:0)
[09:52:06.427] Timer tick, asking Buildbucket for the build status
[09:52:06.554] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:06.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:67:0) after 1m0s
[09:53:06.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:67:0)
[09:53:06.610] Timer tick, asking Buildbucket for the build status
[09:53:06.741] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:06.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:68:0) after 1m0s
[09:54:06.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:68:0)
[09:54:06.809] Timer tick, asking Buildbucket for the build status
[09:54:06.939] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:06.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:69:0) after 1m0s
[09:55:06.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:69:0)
[09:55:06.987] Timer tick, asking Buildbucket for the build status
[09:55:07.132] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:07.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:70:0) after 1m0s
[09:56:07.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:70:0)
[09:56:07.249] Timer tick, asking Buildbucket for the build status
[09:56:07.361] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:07.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:71:0) after 1m0s
[09:57:07.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:71:0)
[09:57:07.550] Timer tick, asking Buildbucket for the build status
[09:57:07.701] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:07.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:72:0) after 1m0s
[09:58:07.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:72:0)
[09:58:07.788] Timer tick, asking Buildbucket for the build status
[09:58:08.005] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:08.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:73:0) after 1m0s
[09:59:08.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:73:0)
[09:59:08.037] Timer tick, asking Buildbucket for the build status
[09:59:08.710] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:08.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:74:0) after 1m0s
[10:00:08.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:74:0)
[10:00:08.737] Timer tick, asking Buildbucket for the build status
[10:00:08.971] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:08.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:75:0) after 1m0s
[10:01:09.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:75:0)
[10:01:09.046] Timer tick, asking Buildbucket for the build status
[10:01:09.233] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:09.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:76:0) after 1m0s
[10:02:09.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:76:0)
[10:02:09.267] Timer tick, asking Buildbucket for the build status
[10:02:09.388] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:09.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:77:0) after 1m0s
[10:03:09.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:77:0)
[10:03:09.413] Timer tick, asking Buildbucket for the build status
[10:03:09.563] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:09.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:78:0) after 1m0s
[10:04:09.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:78:0)
[10:04:09.585] Timer tick, asking Buildbucket for the build status
[10:04:09.970] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:79:0) after 1m0s
[10:05:10.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:79:0)
[10:05:10.196] Timer tick, asking Buildbucket for the build status
[10:05:10.530] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:10.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:80:0) after 1m0s
[10:06:10.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:80:0)
[10:06:10.623] Timer tick, asking Buildbucket for the build status
[10:06:10.806] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:10.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:81:0) after 1m0s
[10:07:10.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:81:0)
[10:07:10.922] Timer tick, asking Buildbucket for the build status
[10:07:11.104] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:11.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:82:0) after 1m0s
[10:08:11.160] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:82:0)
[10:08:11.160] Timer tick, asking Buildbucket for the build status
[10:08:11.366] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:11.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:83:0) after 1m0s
[10:09:11.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:83:0)
[10:09:11.366] Timer tick, asking Buildbucket for the build status
[10:09:11.654] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:11.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:84:0) after 1m0s
[10:10:11.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:84:0)
[10:10:11.720] Timer tick, asking Buildbucket for the build status
[10:10:11.911] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:10:11.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:85:0) after 1m0s
[10:11:11.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:85:0)
[10:11:11.991] Timer tick, asking Buildbucket for the build status
[10:11:12.358] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:12.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:86:0) after 1m0s
[10:12:12.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:86:0)
[10:12:12.437] Timer tick, asking Buildbucket for the build status
[10:12:12.575] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:12.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:87:0) after 1m0s
[10:13:12.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:87:0)
[10:13:12.607] Timer tick, asking Buildbucket for the build status
[10:13:12.738] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:12.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:88:0) after 1m0s
[10:14:12.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:88:0)
[10:14:12.818] Timer tick, asking Buildbucket for the build status
[10:14:12.954] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:12.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:89:0) after 1m0s
[10:15:13.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:89:0)
[10:15:13.014] Timer tick, asking Buildbucket for the build status
[10:15:13.268] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:13.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:90:0) after 1m0s
[10:16:13.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:90:0)
[10:16:13.472] Timer tick, asking Buildbucket for the build status
[10:16:13.622] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:13.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:91:0) after 1m0s
[10:17:13.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:91:0)
[10:17:13.751] Timer tick, asking Buildbucket for the build status
[10:17:13.968] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:13.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:92:0) after 1m0s
[10:18:14.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:92:0)
[10:18:14.096] Timer tick, asking Buildbucket for the build status
[10:18:16.206] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:16.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:93:0) after 1m0s
[10:19:16.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:93:0)
[10:19:16.358] Timer tick, asking Buildbucket for the build status
[10:19:16.872] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:16.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:94:0) after 1m0s
[10:20:16.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:94:0)
[10:20:16.984] Timer tick, asking Buildbucket for the build status
[10:20:17.132] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:17.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:95:0) after 1m0s
[10:21:17.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:95:0)
[10:21:17.236] Timer tick, asking Buildbucket for the build status
[10:21:17.722] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:17.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:96:0) after 1m0s
[10:22:17.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:96:0)
[10:22:17.757] Timer tick, asking Buildbucket for the build status
[10:22:18.514] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:18.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:97:0) after 1m0s
[10:23:18.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:97:0)
[10:23:18.546] Timer tick, asking Buildbucket for the build status
[10:23:18.686] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:18.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:98:0) after 1m0s
[10:24:18.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:98:0)
[10:24:18.719] Timer tick, asking Buildbucket for the build status
[10:24:18.828] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:18.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:99:0) after 1m0s
[10:25:18.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:99:0)
[10:25:18.917] Timer tick, asking Buildbucket for the build status
[10:25:19.240] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:19.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:100:0) after 1m0s
[10:26:19.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:100:0)
[10:26:19.290] Timer tick, asking Buildbucket for the build status
[10:26:19.512] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:19.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:101:0) after 1m0s
[10:27:19.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:101:0)
[10:27:19.624] Timer tick, asking Buildbucket for the build status
[10:27:19.766] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:19.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:102:0) after 1m0s
[10:28:19.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:102:0)
[10:28:19.865] Timer tick, asking Buildbucket for the build status
[10:28:20.062] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:103:0) after 1m0s
[10:29:20.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:103:0)
[10:29:20.088] Timer tick, asking Buildbucket for the build status
[10:29:20.192] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:20.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:104:0) after 1m0s
[10:30:20.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:104:0)
[10:30:20.289] Timer tick, asking Buildbucket for the build status
[10:30:20.520] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:20.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:105:0) after 1m0s
[10:31:20.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:105:0)
[10:31:20.585] Timer tick, asking Buildbucket for the build status
[10:31:20.773] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:20.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:106:0) after 1m0s
[10:32:20.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:106:0)
[10:32:20.818] Timer tick, asking Buildbucket for the build status
[10:32:21.015] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:21.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:107:0) after 1m0s
[10:33:21.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:107:0)
[10:33:21.157] Timer tick, asking Buildbucket for the build status
[10:33:21.443] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:21.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:108:0) after 1m0s
[10:34:21.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:108:0)
[10:34:21.483] Timer tick, asking Buildbucket for the build status
[10:34:21.666] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:21.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:109:0) after 1m0s
[10:35:21.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:109:0)
[10:35:21.696] Timer tick, asking Buildbucket for the build status
[10:35:22.029] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:22.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:110:0) after 1m0s
[10:36:22.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:110:0)
[10:36:22.114] Timer tick, asking Buildbucket for the build status
[10:36:22.336] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:22.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:111:0) after 1m0s
[10:37:22.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:111:0)
[10:37:22.397] Timer tick, asking Buildbucket for the build status
[10:37:23.332] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:23.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:112:0) after 1m0s
[10:38:23.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:112:0)
[10:38:23.420] Timer tick, asking Buildbucket for the build status
[10:38:25.547] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:25.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:113:0) after 1m0s
[10:39:25.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:113:0)
[10:39:25.609] Timer tick, asking Buildbucket for the build status
[10:39:25.746] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:25.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:114:0) after 1m0s
[10:40:25.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:114:0)
[10:40:25.897] Timer tick, asking Buildbucket for the build status
[10:40:26.653] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:26.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:115:0) after 1m0s
[10:41:26.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:115:0)
[10:41:26.891] Timer tick, asking Buildbucket for the build status
[10:41:27.051] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:27.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:116:0) after 1m0s
[10:42:27.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:116:0)
[10:42:27.076] Timer tick, asking Buildbucket for the build status
[10:42:27.390] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:27.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:117:0) after 1m0s
[10:43:27.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:117:0)
[10:43:27.493] Timer tick, asking Buildbucket for the build status
[10:43:27.803] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:27.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:118:0) after 1m0s
[10:44:27.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:118:0)
[10:44:27.821] Timer tick, asking Buildbucket for the build status
[10:44:28.222] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:28.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:119:0) after 1m0s
[10:45:28.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:119:0)
[10:45:28.334] Timer tick, asking Buildbucket for the build status
[10:45:28.450] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:28.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:120:0) after 1m0s
[10:46:28.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:120:0)
[10:46:28.573] Timer tick, asking Buildbucket for the build status
[10:46:28.873] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:28.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:121:0) after 1m0s
[10:47:28.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:121:0)
[10:47:28.985] Timer tick, asking Buildbucket for the build status
[10:47:29.131] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:29.131] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:122:0) after 1m0s
[10:48:29.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:122:0)
[10:48:29.220] Timer tick, asking Buildbucket for the build status
[10:48:29.688] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:123:0) after 1m0s
[10:49:29.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:123:0)
[10:49:29.731] Timer tick, asking Buildbucket for the build status
[10:49:29.964] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:29.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:124:0) after 1m0s
[10:50:30.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:124:0)
[10:50:30.031] Timer tick, asking Buildbucket for the build status
[10:50:34.935] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:34.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:125:0) after 1m0s
[10:51:35.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:125:0)
[10:51:35.006] Timer tick, asking Buildbucket for the build status
[10:51:35.128] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:35.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:126:0) after 1m0s
[10:52:35.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:126:0)
[10:52:35.196] Timer tick, asking Buildbucket for the build status
[10:52:36.275] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:36.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:127:0) after 1m0s
[10:53:36.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:127:0)
[10:53:36.307] Timer tick, asking Buildbucket for the build status
[10:53:36.431] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:36.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:128:0) after 1m0s
[10:54:36.491] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:128:0)
[10:54:36.491] Timer tick, asking Buildbucket for the build status
[10:54:36.596] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:36.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:129:0) after 1m0s
[10:55:36.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:129:0)
[10:55:36.688] Timer tick, asking Buildbucket for the build status
[10:55:37.180] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:37.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:130:0) after 1m0s
[10:56:37.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:130:0)
[10:56:37.245] Timer tick, asking Buildbucket for the build status
[10:56:37.420] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:37.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:131:0) after 1m0s
[10:57:37.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:131:0)
[10:57:37.494] Timer tick, asking Buildbucket for the build status
[10:57:37.785] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:37.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:132:0) after 1m0s
[10:58:37.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:132:0)
[10:58:37.771] Timer tick, asking Buildbucket for the build status
[10:58:37.886] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:37.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:133:0) after 1m0s
[10:59:37.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:133:0)
[10:59:37.906] Timer tick, asking Buildbucket for the build status
[10:59:38.168] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:38.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:134:0) after 1m0s
[11:00:38.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:134:0)
[11:00:38.207] Timer tick, asking Buildbucket for the build status
[11:00:38.552] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:38.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:135:0) after 1m0s
[11:01:38.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:135:0)
[11:01:38.589] Timer tick, asking Buildbucket for the build status
[11:01:38.740] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:38.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:136:0) after 1m0s
[11:02:38.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:136:0)
[11:02:38.810] Timer tick, asking Buildbucket for the build status
[11:02:38.981] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:38.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:137:0) after 1m0s
[11:03:38.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:137:0)
[11:03:38.966] Timer tick, asking Buildbucket for the build status
[11:03:39.469] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:39.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:138:0) after 1m0s
[11:04:39.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:138:0)
[11:04:39.501] Timer tick, asking Buildbucket for the build status
[11:04:39.614] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:39.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:139:0) after 1m0s
[11:05:39.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:139:0)
[11:05:39.713] Timer tick, asking Buildbucket for the build status
[11:05:42.372] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:42.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:140:0) after 1m0s
[11:06:42.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:140:0)
[11:06:42.411] Timer tick, asking Buildbucket for the build status
[11:06:42.797] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:42.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:141:0) after 1m0s
[11:07:42.834] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:141:0)
[11:07:42.834] Timer tick, asking Buildbucket for the build status
[11:07:43.103] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:43.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:142:0) after 1m0s
[11:08:43.144] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:142:0)
[11:08:43.144] Timer tick, asking Buildbucket for the build status
[11:08:43.310] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:43.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:143:0) after 1m0s
[11:09:43.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:143:0)
[11:09:43.362] Timer tick, asking Buildbucket for the build status
[11:09:43.700] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:43.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:144:0) after 1m0s
[11:10:43.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:144:0)
[11:10:43.707] Timer tick, asking Buildbucket for the build status
[11:10:44.209] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:44.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:145:0) after 1m0s
[11:11:44.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:145:0)
[11:11:44.340] Timer tick, asking Buildbucket for the build status
[11:11:44.480] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:44.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:146:0) after 1m0s
[11:12:44.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:146:0)
[11:12:44.613] Timer tick, asking Buildbucket for the build status
[11:12:44.743] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:44.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:147:0) after 1m0s
[11:13:44.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:147:0)
[11:13:44.838] Timer tick, asking Buildbucket for the build status
[11:13:44.916] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:44.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:148:0) after 1m0s
[11:14:45.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:148:0)
[11:14:45.131] Timer tick, asking Buildbucket for the build status
[11:14:45.258] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:45.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:149:0) after 1m0s
[11:15:45.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:149:0)
[11:15:45.439] Timer tick, asking Buildbucket for the build status
[11:15:45.599] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:45.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:150:0) after 1m0s
[11:16:46.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:150:0)
[11:16:46.071] Timer tick, asking Buildbucket for the build status
[11:16:46.314] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:46.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:151:0) after 1m0s
[11:17:46.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:151:0)
[11:17:46.451] Timer tick, asking Buildbucket for the build status
[11:17:46.658] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:46.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:152:0) after 1m0s
[11:18:46.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:152:0)
[11:18:46.779] Timer tick, asking Buildbucket for the build status
[11:18:46.991] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:46.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:153:0) after 1m0s
[11:19:47.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:153:0)
[11:19:47.105] Timer tick, asking Buildbucket for the build status
[11:19:47.600] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:47.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:154:0) after 1m0s
[11:20:47.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:154:0)
[11:20:47.738] Timer tick, asking Buildbucket for the build status
[11:20:48.109] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:48.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:155:0) after 1m0s
[11:21:48.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:155:0)
[11:21:48.327] Timer tick, asking Buildbucket for the build status
[11:21:48.480] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:48.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:156:0) after 1m0s
[11:22:48.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:156:0)
[11:22:48.713] Timer tick, asking Buildbucket for the build status
[11:22:49.012] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:49.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:157:0) after 1m0s
[11:23:49.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:157:0)
[11:23:49.354] Timer tick, asking Buildbucket for the build status
[11:23:49.697] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:49.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:158:0) after 1m0s
[11:24:49.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:158:0)
[11:24:49.869] Timer tick, asking Buildbucket for the build status
[11:24:50.033] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:50.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:159:0) after 1m0s
[11:25:50.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:159:0)
[11:25:50.195] Timer tick, asking Buildbucket for the build status
[11:25:50.422] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:50.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:160:0) after 1m0s
[11:26:50.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:160:0)
[11:26:50.603] Timer tick, asking Buildbucket for the build status
[11:26:50.755] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:50.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:161:0) after 1m0s
[11:27:50.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:161:0)
[11:27:50.788] Timer tick, asking Buildbucket for the build status
[11:27:50.893] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:50.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:162:0) after 1m0s
[11:28:50.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:162:0)
[11:28:50.927] Timer tick, asking Buildbucket for the build status
[11:28:51.024] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:51.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:163:0) after 1m0s
[11:29:51.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:163:0)
[11:29:51.119] Timer tick, asking Buildbucket for the build status
[11:29:51.481] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:51.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:164:0) after 1m0s
[11:30:51.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:164:0)
[11:30:51.527] Timer tick, asking Buildbucket for the build status
[11:30:51.629] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:51.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:165:0) after 1m0s
[11:31:51.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:165:0)
[11:31:51.737] Timer tick, asking Buildbucket for the build status
[11:31:51.849] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:51.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:166:0) after 1m0s
[11:32:51.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:166:0)
[11:32:51.913] Timer tick, asking Buildbucket for the build status
[11:32:52.056] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:52.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:167:0) after 1m0s
[11:33:52.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:167:0)
[11:33:52.142] Timer tick, asking Buildbucket for the build status
[11:33:52.716] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:52.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:168:0) after 1m0s
[11:34:52.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:168:0)
[11:34:52.797] Timer tick, asking Buildbucket for the build status
[11:34:52.929] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:52.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:169:0) after 1m0s
[11:35:52.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:169:0)
[11:35:52.969] Timer tick, asking Buildbucket for the build status
[11:35:53.418] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:53.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:170:0) after 1m0s
[11:36:53.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:170:0)
[11:36:53.462] Timer tick, asking Buildbucket for the build status
[11:36:54.024] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:54.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:171:0) after 1m0s
[11:37:54.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:171:0)
[11:37:54.033] Timer tick, asking Buildbucket for the build status
[11:37:54.243] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:54.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:172:0) after 1m0s
[11:38:54.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:172:0)
[11:38:54.261] Timer tick, asking Buildbucket for the build status
[11:38:56.734] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:56.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:173:0) after 1m0s
[11:39:56.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:173:0)
[11:39:56.846] Timer tick, asking Buildbucket for the build status
[11:39:56.956] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:56.956] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:174:0) after 1m0s
[11:40:56.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:174:0)
[11:40:56.996] Timer tick, asking Buildbucket for the build status
[11:40:57.173] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:57.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:175:0) after 1m0s
[11:41:57.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:175:0)
[11:41:57.281] Timer tick, asking Buildbucket for the build status
[11:41:57.414] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:57.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:176:0) after 1m0s
[11:42:57.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:176:0)
[11:42:57.485] Timer tick, asking Buildbucket for the build status
[11:42:57.587] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:57.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:177:0) after 1m0s
[11:43:57.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:177:0)
[11:43:57.797] Timer tick, asking Buildbucket for the build status
[11:43:57.944] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:57.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:178:0) after 1m0s
[11:44:58.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:178:0)
[11:44:58.096] Timer tick, asking Buildbucket for the build status
[11:44:58.262] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:58.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:179:0) after 1m0s
[11:45:58.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:179:0)
[11:45:58.467] Timer tick, asking Buildbucket for the build status
[11:45:58.745] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:58.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:180:0) after 1m0s
[11:46:58.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:180:0)
[11:46:58.912] Timer tick, asking Buildbucket for the build status
[11:46:59.019] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:59.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:181:0) after 1m0s
[11:47:59.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:181:0)
[11:47:59.216] Timer tick, asking Buildbucket for the build status
[11:47:59.408] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:59.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:182:0) after 1m0s
[11:48:59.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:182:0)
[11:48:59.547] Timer tick, asking Buildbucket for the build status
[11:48:59.922] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:59.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:183:0) after 1m0s
[11:49:59.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:183:0)
[11:49:59.925] Timer tick, asking Buildbucket for the build status
[11:50:00.165] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:00.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:184:0) after 1m0s
[11:51:00.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:184:0)
[11:51:00.244] Timer tick, asking Buildbucket for the build status
[11:51:00.357] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:00.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:185:0) after 1m0s
[11:52:01.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:185:0)
[11:52:01.913] Timer tick, asking Buildbucket for the build status
[11:52:02.560] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:02.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:186:0) after 1m0s
[11:53:02.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:186:0)
[11:53:02.767] Timer tick, asking Buildbucket for the build status
[11:53:02.899] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:02.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:187:0) after 1m0s
[11:54:03.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:187:0)
[11:54:03.380] Timer tick, asking Buildbucket for the build status
[11:54:03.921] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:03.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:188:0) after 1m0s
[11:55:03.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:188:0)
[11:55:03.959] Timer tick, asking Buildbucket for the build status
[11:55:04.142] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:04.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:189:0) after 1m0s
[11:56:04.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:189:0)
[11:56:04.364] Timer tick, asking Buildbucket for the build status
[11:56:04.496] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:04.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:190:0) after 1m0s
[11:57:04.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:190:0)
[11:57:04.679] Timer tick, asking Buildbucket for the build status
[11:57:05.076] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:05.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:191:0) after 1m0s
[11:58:05.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:191:0)
[11:58:05.341] Timer tick, asking Buildbucket for the build status
[11:58:05.703] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:05.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:192:0) after 1m0s
[11:59:05.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:192:0)
[11:59:05.790] Timer tick, asking Buildbucket for the build status
[11:59:06.182] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:193:0) after 1m0s
[12:00:06.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:193:0)
[12:00:06.239] Timer tick, asking Buildbucket for the build status
[12:00:06.416] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:06.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:194:0) after 1m0s
[12:01:06.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:194:0)
[12:01:06.638] Timer tick, asking Buildbucket for the build status
[12:01:06.994] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:06.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:195:0) after 1m0s
[12:02:07.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:195:0)
[12:02:07.078] Timer tick, asking Buildbucket for the build status
[12:02:07.252] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:196:0) after 1m0s
[12:03:07.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:196:0)
[12:03:07.600] Timer tick, asking Buildbucket for the build status
[12:03:07.977] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:07.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:197:0) after 1m0s
[12:04:08.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:197:0)
[12:04:08.067] Timer tick, asking Buildbucket for the build status
[12:04:08.432] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:08.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:198:0) after 1m0s
[12:05:08.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:198:0)
[12:05:08.573] Timer tick, asking Buildbucket for the build status
[12:05:08.744] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:08.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:199:0) after 1m0s
[12:06:08.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:199:0)
[12:06:08.879] Timer tick, asking Buildbucket for the build status
[12:06:09.601] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:09.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:200:0) after 1m0s
[12:07:09.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:200:0)
[12:07:09.678] Timer tick, asking Buildbucket for the build status
[12:07:10.052] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:10.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:201:0) after 1m0s
[12:08:10.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:201:0)
[12:08:10.133] Timer tick, asking Buildbucket for the build status
[12:08:10.561] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:10.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:202:0) after 1m0s
[12:09:10.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:202:0)
[12:09:10.660] Timer tick, asking Buildbucket for the build status
[12:09:11.875] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:11.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:203:0) after 1m0s
[12:10:12.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:203:0)
[12:10:12.841] Timer tick, asking Buildbucket for the build status
[12:10:13.305] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:13.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:204:0) after 1m0s
[12:11:14.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:204:0)
[12:11:14.016] Timer tick, asking Buildbucket for the build status
[12:11:14.899] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:14.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:205:0) after 1m0s
[12:12:15.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:205:0)
[12:12:15.504] Timer tick, asking Buildbucket for the build status
[12:12:16.469] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:16.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:206:0) after 1m0s
[12:13:16.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:206:0)
[12:13:16.759] Timer tick, asking Buildbucket for the build status
[12:13:16.862] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:16.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:207:0) after 1m0s
[12:14:19.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:207:0)
[12:14:19.731] Timer tick, asking Buildbucket for the build status
[12:14:19.933] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:19.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:208:0) after 1m0s
[12:15:19.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:208:0)
[12:15:19.967] Timer tick, asking Buildbucket for the build status
[12:15:20.366] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:20.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:209:0) after 1m0s
[12:16:20.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:209:0)
[12:16:20.406] Timer tick, asking Buildbucket for the build status
[12:16:21.042] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:21.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:210:0) after 1m0s
[12:17:21.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:210:0)
[12:17:21.087] Timer tick, asking Buildbucket for the build status
[12:17:21.250] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:21.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:211:0) after 1m0s
[12:18:21.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:211:0)
[12:18:21.280] Timer tick, asking Buildbucket for the build status
[12:18:21.739] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:21.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:212:0) after 1m0s
[12:19:21.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:212:0)
[12:19:21.800] Timer tick, asking Buildbucket for the build status
[12:19:21.933] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:21.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:213:0) after 1m0s
[12:20:21.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:213:0)
[12:20:21.991] Timer tick, asking Buildbucket for the build status
[12:20:22.305] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:22.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:214:0) after 1m0s
[12:21:22.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:214:0)
[12:21:22.399] Timer tick, asking Buildbucket for the build status
[12:21:22.606] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:22.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:215:0) after 1m0s
[12:22:22.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:215:0)
[12:22:22.688] Timer tick, asking Buildbucket for the build status
[12:22:23.401] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:23.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:216:0) after 1m0s
[12:23:23.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:216:0)
[12:23:23.508] Timer tick, asking Buildbucket for the build status
[12:23:23.727] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:23.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:217:0) after 1m0s
[12:24:23.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:217:0)
[12:24:23.766] Timer tick, asking Buildbucket for the build status
[12:24:24.074] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:24.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:218:0) after 1m0s
[12:25:24.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:218:0)
[12:25:24.115] Timer tick, asking Buildbucket for the build status
[12:25:24.468] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:24.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:219:0) after 1m0s
[12:26:24.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:219:0)
[12:26:24.667] Timer tick, asking Buildbucket for the build status
[12:26:24.814] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:24.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:220:0) after 1m0s
[12:27:24.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:220:0)
[12:27:24.851] Timer tick, asking Buildbucket for the build status
[12:27:24.953] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:24.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:221:0) after 1m0s
[12:28:24.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:221:0)
[12:28:24.981] Timer tick, asking Buildbucket for the build status
[12:28:25.229] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:25.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:222:0) after 1m0s
[12:29:25.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:222:0)
[12:29:25.289] Timer tick, asking Buildbucket for the build status
[12:29:25.495] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:25.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:223:0) after 1m0s
[12:30:25.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:223:0)
[12:30:25.599] Timer tick, asking Buildbucket for the build status
[12:30:26.536] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:26.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:224:0) after 1m0s
[12:31:26.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:224:0)
[12:31:26.554] Timer tick, asking Buildbucket for the build status
[12:31:26.719] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:26.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:225:0) after 1m0s
[12:32:26.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:225:0)
[12:32:26.799] Timer tick, asking Buildbucket for the build status
[12:32:27.333] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:27.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:226:0) after 1m0s
[12:33:27.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:226:0)
[12:33:27.396] Timer tick, asking Buildbucket for the build status
[12:33:27.860] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:27.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:227:0) after 1m0s
[12:34:27.896] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:227:0)
[12:34:27.896] Timer tick, asking Buildbucket for the build status
[12:34:28.074] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:28.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:228:0) after 1m0s
[12:35:28.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:228:0)
[12:35:28.107] Timer tick, asking Buildbucket for the build status
[12:35:28.229] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:28.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:229:0) after 1m0s
[12:36:28.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:229:0)
[12:36:28.465] Timer tick, asking Buildbucket for the build status
[12:36:28.640] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:28.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:230:0) after 1m0s
[12:37:28.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:230:0)
[12:37:28.766] Timer tick, asking Buildbucket for the build status
[12:37:28.926] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:28.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:231:0) after 1m0s
[12:38:28.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:231:0)
[12:38:28.974] Timer tick, asking Buildbucket for the build status
[12:38:29.226] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:29.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:232:0) after 1m0s
[12:39:29.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:232:0)
[12:39:29.309] Timer tick, asking Buildbucket for the build status
[12:39:29.566] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:29.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:233:0) after 1m0s
[12:40:29.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:233:0)
[12:40:29.639] Timer tick, asking Buildbucket for the build status
[12:40:29.967] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:29.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:234:0) after 1m0s
[12:41:30.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:234:0)
[12:41:30.012] Timer tick, asking Buildbucket for the build status
[12:41:30.181] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:30.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:235:0) after 1m0s
[12:42:30.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:235:0)
[12:42:30.220] Timer tick, asking Buildbucket for the build status
[12:42:30.372] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:30.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:236:0) after 1m0s
[12:43:30.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:236:0)
[12:43:30.428] Timer tick, asking Buildbucket for the build status
[12:43:30.561] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:30.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:237:0) after 1m0s
[12:44:30.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:237:0)
[12:44:30.616] Timer tick, asking Buildbucket for the build status
[12:44:30.934] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:30.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:238:0) after 1m0s
[12:45:31.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:238:0)
[12:45:31.023] Timer tick, asking Buildbucket for the build status
[12:45:31.651] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:31.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:239:0) after 1m0s
[12:46:31.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:239:0)
[12:46:31.666] Timer tick, asking Buildbucket for the build status
[12:46:31.810] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:31.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:240:0) after 1m0s
[12:47:31.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:240:0)
[12:47:31.872] Timer tick, asking Buildbucket for the build status
[12:47:32.068] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:32.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:241:0) after 1m0s
[12:48:32.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:241:0)
[12:48:32.114] Timer tick, asking Buildbucket for the build status
[12:48:32.303] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:32.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:242:0) after 1m0s
[12:49:32.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:242:0)
[12:49:32.487] Timer tick, asking Buildbucket for the build status
[12:49:32.612] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:32.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:243:0) after 1m0s
[12:50:32.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:243:0)
[12:50:32.738] Timer tick, asking Buildbucket for the build status
[12:50:32.860] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:32.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:244:0) after 1m0s
[12:51:32.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:244:0)
[12:51:32.926] Timer tick, asking Buildbucket for the build status
[12:51:33.177] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:33.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:245:0) after 1m0s
[12:52:33.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:245:0)
[12:52:33.192] Timer tick, asking Buildbucket for the build status
[12:52:33.342] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:33.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:246:0) after 1m0s
[12:53:33.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:246:0)
[12:53:33.435] Timer tick, asking Buildbucket for the build status
[12:53:33.871] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:33.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:247:0) after 1m0s
[12:54:33.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:247:0)
[12:54:33.985] Timer tick, asking Buildbucket for the build status
[12:54:34.093] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:34.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:248:0) after 1m0s
[12:55:34.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:248:0)
[12:55:34.155] Timer tick, asking Buildbucket for the build status
[12:55:34.519] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:34.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:249:0) after 1m0s
[12:56:34.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:249:0)
[12:56:34.658] Timer tick, asking Buildbucket for the build status
[12:56:34.824] Build 8879795146650280832: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:34.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9045225208830281328:250:0) after 1m0s
[12:57:20.435] Received PubSub notification, asking Buildbucket for the build status
[12:57:20.675] Build 8879795146650280832: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:57:20.675] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1589979437012816",
"created_by": "project:chromium",
"created_ts": "1589964455898608",
"id": "8879795146650280832",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-vzwx\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 16528, \"got_angle_revision\": \"d45b30b5a554042166fe5fe03d468a80394e88af\", \"got_dawn_revision\": \"78f7e8640f1452eab5a31bd07ec955b3a41d0aba\", \"got_nacl_revision\": \"87616f7ce2ea8383efd3731960c15f4ba5852d93\", \"got_revision\": \"b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565\", \"got_revision_cp\": \"refs/heads/master@{#770516}\", \"got_swarming_client_revision\": \"7e8636295f4763a5f5aace1e700b17a4af3c81b7\", \"got_swiftshader_revision\": \"b6e8c3f0f4830887d69ba765a922ac3c40e81dd9\", \"got_v8_revision\": \"b072390cd31323aec324401a835bc319b94878d4\", \"got_v8_revision_cp\": \"refs/heads/8.5.29@{#1}\", \"got_webrtc_revision\": \"4ab61cb9b4499a5e92d29abf5c0df90ca7fdc95c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#31328}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565\"}, \"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-vzwx\"], \"image\": [\"chrome-win10-1703-20042500-5e6af220c3f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5100-d2625c1\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1589964755341947",
"status": "COMPLETED",
"status_changed_ts": "1589979437409270",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/16528",
"builder:Windows deterministic",
"buildset:commit/git/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b4c3a66a255fbbf41ee89ddf4ba2a382b7b88565",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045225208830281328",
"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/8879795146650280832/+/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:4c4a15cb0b4a4310",
"user_agent:luci-scheduler"
],
"updated_ts": "1589979437416230",
"url": "https://ci.chromium.org/b/8879795146650280832",
"utcnow_ts": "1589979440648492"
}
}
[12:57:20.675] Invocation finished in 4h9m46.238772587s with status SUCCEEDED