[20:12:12.355] New invocation is queued and will start shortly
[20:12:13.431] Starting the invocation (attempt 1)
[20:12:13.471] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:12:13.472] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:12:13.472] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058046904755574720",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6e9c7d5b750c3d2a541672505fd3a1a67dc93792\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9058046904755574720",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"gitiles_ref:refs/heads/master"
]
}
[20:12:14.280] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577736733630301",
"id": "8892616842755720912",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e9c7d5b750c3d2a541672505fd3a1a67dc93792\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577736734103671",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15589",
"builder:Windows deterministic",
"buildset:commit/git/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058046904755574720",
"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/8892616842755720912/+/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": "1577736734103774",
"url": "https://ci.chromium.org/b/8892616842755720912",
"utcnow_ts": "1577736734270390"
}
}
[20:12:14.280] Task URL: https://ci.chromium.org/b/8892616842755720912
[20:12:14.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:2:0) after 1m0s
[20:12:21.650] Received PubSub notification, asking Buildbucket for the build status
[20:12:21.751] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:14.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:2:0)
[20:13:14.397] Timer tick, asking Buildbucket for the build status
[20:13:15.753] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:15.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:4:0) after 1m0s
[20:14:15.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:4:0)
[20:14:15.776] Timer tick, asking Buildbucket for the build status
[20:14:15.968] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:15.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:5:0) after 1m0s
[20:15:15.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:5:0)
[20:15:15.987] Timer tick, asking Buildbucket for the build status
[20:15:16.169] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:16.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:6:0) after 1m0s
[20:16:16.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:6:0)
[20:16:16.276] Timer tick, asking Buildbucket for the build status
[20:16:17.094] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:7:0) after 1m0s
[20:17:17.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:7:0)
[20:17:17.260] Timer tick, asking Buildbucket for the build status
[20:17:17.775] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:17.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:8:0) after 1m0s
[20:18:17.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:8:0)
[20:18:17.791] Timer tick, asking Buildbucket for the build status
[20:18:18.557] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:18.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:9:0) after 1m0s
[20:19:18.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:9:0)
[20:19:18.874] Timer tick, asking Buildbucket for the build status
[20:19:19.079] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:19.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:10:0) after 1m0s
[20:20:19.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:10:0)
[20:20:19.164] Timer tick, asking Buildbucket for the build status
[20:20:19.386] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:19.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:11:0) after 1m0s
[20:21:19.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:11:0)
[20:21:19.453] Timer tick, asking Buildbucket for the build status
[20:21:19.638] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:19.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:12:0) after 1m0s
[20:22:19.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:12:0)
[20:22:19.763] Timer tick, asking Buildbucket for the build status
[20:22:20.409] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:20.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:13:0) after 1m0s
[20:23:20.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:13:0)
[20:23:20.489] Timer tick, asking Buildbucket for the build status
[20:23:21.411] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:21.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:14:0) after 1m0s
[20:24:21.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:14:0)
[20:24:21.504] Timer tick, asking Buildbucket for the build status
[20:24:21.758] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:21.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:15:0) after 1m0s
[20:25:21.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:15:0)
[20:25:21.890] Timer tick, asking Buildbucket for the build status
[20:25:22.488] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:22.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:16:0) after 1m0s
[20:26:22.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:16:0)
[20:26:22.550] Timer tick, asking Buildbucket for the build status
[20:26:22.791] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:22.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:17:0) after 1m0s
[20:27:22.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:17:0)
[20:27:22.820] Timer tick, asking Buildbucket for the build status
[20:27:23.011] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:23.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:18:0) after 1m0s
[20:28:23.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:18:0)
[20:28:23.101] Timer tick, asking Buildbucket for the build status
[20:28:23.365] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:23.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:19:0) after 1m0s
[20:29:23.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:19:0)
[20:29:23.449] Timer tick, asking Buildbucket for the build status
[20:29:23.791] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:23.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:20:0) after 1m0s
[20:30:23.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:20:0)
[20:30:23.914] Timer tick, asking Buildbucket for the build status
[20:30:24.121] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:24.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:21:0) after 1m0s
[20:31:24.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:21:0)
[20:31:24.273] Timer tick, asking Buildbucket for the build status
[20:31:24.443] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:24.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:22:0) after 1m0s
[20:32:24.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:22:0)
[20:32:24.647] Timer tick, asking Buildbucket for the build status
[20:32:26.751] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:26.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:23:0) after 1m0s
[20:33:26.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:23:0)
[20:33:26.799] Timer tick, asking Buildbucket for the build status
[20:33:26.968] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:26.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:24:0) after 1m0s
[20:34:26.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:24:0)
[20:34:26.999] Timer tick, asking Buildbucket for the build status
[20:34:27.161] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:27.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:25:0) after 1m0s
[20:35:27.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:25:0)
[20:35:27.178] Timer tick, asking Buildbucket for the build status
[20:35:27.558] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:27.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:26:0) after 1m0s
[20:36:27.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:26:0)
[20:36:27.598] Timer tick, asking Buildbucket for the build status
[20:36:27.794] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:27.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:27:0) after 1m0s
[20:37:27.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:27:0)
[20:37:27.803] Timer tick, asking Buildbucket for the build status
[20:37:27.991] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:27.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:28:0) after 1m0s
[20:38:28.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:28:0)
[20:38:28.044] Timer tick, asking Buildbucket for the build status
[20:38:28.236] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:28.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:29:0) after 1m0s
[20:39:28.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:29:0)
[20:39:28.281] Timer tick, asking Buildbucket for the build status
[20:39:28.662] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:28.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:30:0) after 1m0s
[20:40:28.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:30:0)
[20:40:28.741] Timer tick, asking Buildbucket for the build status
[20:40:28.968] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:28.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:31:0) after 1m0s
[20:41:29.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:31:0)
[20:41:29.079] Timer tick, asking Buildbucket for the build status
[20:41:29.269] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:29.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:32:0) after 1m0s
[20:42:29.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:32:0)
[20:42:29.319] Timer tick, asking Buildbucket for the build status
[20:42:29.518] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:29.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:33:0) after 1m0s
[20:43:29.579] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:33:0)
[20:43:29.579] Timer tick, asking Buildbucket for the build status
[20:43:29.825] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:29.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:34:0) after 1m0s
[20:44:29.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:34:0)
[20:44:29.852] Timer tick, asking Buildbucket for the build status
[20:44:31.146] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:31.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:35:0) after 1m0s
[20:45:31.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:35:0)
[20:45:31.225] Timer tick, asking Buildbucket for the build status
[20:45:31.879] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:31.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:36:0) after 1m0s
[20:46:31.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:36:0)
[20:46:31.931] Timer tick, asking Buildbucket for the build status
[20:46:32.461] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:32.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:37:0) after 1m0s
[20:47:32.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:37:0)
[20:47:32.484] Timer tick, asking Buildbucket for the build status
[20:47:32.613] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:32.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:38:0) after 1m0s
[20:48:32.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:38:0)
[20:48:32.629] Timer tick, asking Buildbucket for the build status
[20:48:32.863] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:32.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:39:0) after 1m0s
[20:49:32.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:39:0)
[20:49:32.883] Timer tick, asking Buildbucket for the build status
[20:49:33.574] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:33.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:40:0) after 1m0s
[20:50:33.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:40:0)
[20:50:33.622] Timer tick, asking Buildbucket for the build status
[20:50:33.779] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:33.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:41:0) after 1m0s
[20:51:33.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:41:0)
[20:51:33.806] Timer tick, asking Buildbucket for the build status
[20:51:34.380] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:34.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:42:0) after 1m0s
[20:52:34.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:42:0)
[20:52:34.404] Timer tick, asking Buildbucket for the build status
[20:52:34.754] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:34.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:43:0) after 1m0s
[20:53:34.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:43:0)
[20:53:34.791] Timer tick, asking Buildbucket for the build status
[20:53:35.009] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:35.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:44:0) after 1m0s
[20:54:35.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:44:0)
[20:54:35.103] Timer tick, asking Buildbucket for the build status
[20:54:35.312] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:35.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:45:0) after 1m0s
[20:55:35.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:45:0)
[20:55:35.360] Timer tick, asking Buildbucket for the build status
[20:55:35.673] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:35.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:46:0) after 1m0s
[20:56:35.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:46:0)
[20:56:35.688] Timer tick, asking Buildbucket for the build status
[20:56:35.810] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:35.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:47:0) after 1m0s
[20:57:35.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:47:0)
[20:57:35.864] Timer tick, asking Buildbucket for the build status
[20:57:36.376] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:36.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:48:0) after 1m0s
[20:58:36.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:48:0)
[20:58:36.421] Timer tick, asking Buildbucket for the build status
[20:58:37.094] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:37.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:49:0) after 1m0s
[20:59:37.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:49:0)
[20:59:37.169] Timer tick, asking Buildbucket for the build status
[20:59:37.352] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:37.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:50:0) after 1m0s
[21:00:37.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:50:0)
[21:00:37.378] Timer tick, asking Buildbucket for the build status
[21:00:37.544] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:37.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:51:0) after 1m0s
[21:01:37.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:51:0)
[21:01:37.761] Timer tick, asking Buildbucket for the build status
[21:01:37.944] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:37.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:52:0) after 1m0s
[21:02:38.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:52:0)
[21:02:38.006] Timer tick, asking Buildbucket for the build status
[21:02:38.179] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:38.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:53:0) after 1m0s
[21:03:38.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:53:0)
[21:03:38.204] Timer tick, asking Buildbucket for the build status
[21:03:38.382] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:38.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:54:0) after 1m0s
[21:04:38.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:54:0)
[21:04:38.432] Timer tick, asking Buildbucket for the build status
[21:04:38.651] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:38.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:55:0) after 1m0s
[21:05:38.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:55:0)
[21:05:38.655] Timer tick, asking Buildbucket for the build status
[21:05:39.970] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:39.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:56:0) after 1m0s
[21:06:40.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:56:0)
[21:06:40.001] Timer tick, asking Buildbucket for the build status
[21:06:40.302] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:57:0) after 1m0s
[21:07:40.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:57:0)
[21:07:40.328] Timer tick, asking Buildbucket for the build status
[21:07:40.481] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:40.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:58:0) after 1m0s
[21:08:40.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:58:0)
[21:08:40.534] Timer tick, asking Buildbucket for the build status
[21:08:40.942] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:40.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:59:0) after 1m0s
[21:09:41.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:59:0)
[21:09:41.032] Timer tick, asking Buildbucket for the build status
[21:09:41.282] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:41.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:60:0) after 1m0s
[21:10:41.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:60:0)
[21:10:41.322] Timer tick, asking Buildbucket for the build status
[21:10:41.466] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:41.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:61:0) after 1m0s
[21:11:41.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:61:0)
[21:11:41.557] Timer tick, asking Buildbucket for the build status
[21:11:41.909] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:41.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:62:0) after 1m0s
[21:12:41.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:62:0)
[21:12:41.957] Timer tick, asking Buildbucket for the build status
[21:12:42.138] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:42.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:63:0) after 1m0s
[21:13:42.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:63:0)
[21:13:42.192] Timer tick, asking Buildbucket for the build status
[21:13:42.781] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:42.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:64:0) after 1m0s
[21:14:42.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:64:0)
[21:14:42.808] Timer tick, asking Buildbucket for the build status
[21:14:43.474] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:43.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:65:0) after 1m0s
[21:15:43.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:65:0)
[21:15:43.522] Timer tick, asking Buildbucket for the build status
[21:15:43.850] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:43.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:66:0) after 1m0s
[21:16:43.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:66:0)
[21:16:43.925] Timer tick, asking Buildbucket for the build status
[21:16:44.118] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:44.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:67:0) after 1m0s
[21:17:44.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:67:0)
[21:17:44.149] Timer tick, asking Buildbucket for the build status
[21:17:44.749] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:44.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:68:0) after 1m0s
[21:18:44.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:68:0)
[21:18:44.749] Timer tick, asking Buildbucket for the build status
[21:18:45.314] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:45.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:69:0) after 1m0s
[21:19:45.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:69:0)
[21:19:45.336] Timer tick, asking Buildbucket for the build status
[21:19:45.476] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:45.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:70:0) after 1m0s
[21:20:45.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:70:0)
[21:20:45.522] Timer tick, asking Buildbucket for the build status
[21:20:45.678] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:45.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:71:0) after 1m0s
[21:21:45.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:71:0)
[21:21:45.707] Timer tick, asking Buildbucket for the build status
[21:21:45.912] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:45.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:72:0) after 1m0s
[21:22:45.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:72:0)
[21:22:45.938] Timer tick, asking Buildbucket for the build status
[21:22:46.321] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:46.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:73:0) after 1m0s
[21:23:46.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:73:0)
[21:23:46.343] Timer tick, asking Buildbucket for the build status
[21:23:46.761] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:46.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:74:0) after 1m0s
[21:24:46.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:74:0)
[21:24:46.785] Timer tick, asking Buildbucket for the build status
[21:24:46.933] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:46.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:75:0) after 1m0s
[21:25:46.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:75:0)
[21:25:46.956] Timer tick, asking Buildbucket for the build status
[21:25:47.512] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:47.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:76:0) after 1m0s
[21:26:47.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:76:0)
[21:26:47.558] Timer tick, asking Buildbucket for the build status
[21:26:47.816] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:47.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:77:0) after 1m0s
[21:27:47.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:77:0)
[21:27:47.910] Timer tick, asking Buildbucket for the build status
[21:27:48.353] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:48.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:78:0) after 1m0s
[21:28:48.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:78:0)
[21:28:48.405] Timer tick, asking Buildbucket for the build status
[21:28:48.737] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:48.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:79:0) after 1m0s
[21:29:48.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:79:0)
[21:29:48.773] Timer tick, asking Buildbucket for the build status
[21:29:49.274] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:49.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:80:0) after 1m0s
[21:30:49.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:80:0)
[21:30:49.350] Timer tick, asking Buildbucket for the build status
[21:30:50.145] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:50.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:81:0) after 1m0s
[21:31:50.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:81:0)
[21:31:50.324] Timer tick, asking Buildbucket for the build status
[21:31:50.549] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:50.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:82:0) after 1m0s
[21:32:50.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:82:0)
[21:32:50.581] Timer tick, asking Buildbucket for the build status
[21:32:50.798] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:50.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:83:0) after 1m0s
[21:33:50.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:83:0)
[21:33:50.827] Timer tick, asking Buildbucket for the build status
[21:33:51.034] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:51.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:84:0) after 1m0s
[21:34:51.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:84:0)
[21:34:51.074] Timer tick, asking Buildbucket for the build status
[21:34:51.397] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:51.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:85:0) after 1m0s
[21:35:51.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:85:0)
[21:35:51.388] Timer tick, asking Buildbucket for the build status
[21:35:51.569] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:51.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:86:0) after 1m0s
[21:36:51.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:86:0)
[21:36:51.590] Timer tick, asking Buildbucket for the build status
[21:36:52.160] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:52.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:87:0) after 1m0s
[21:37:52.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:87:0)
[21:37:52.212] Timer tick, asking Buildbucket for the build status
[21:37:52.320] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:52.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:88:0) after 1m0s
[21:38:52.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:88:0)
[21:38:52.312] Timer tick, asking Buildbucket for the build status
[21:38:52.454] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:52.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:89:0) after 1m0s
[21:39:52.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:89:0)
[21:39:52.527] Timer tick, asking Buildbucket for the build status
[21:39:52.723] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:52.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:90:0) after 1m0s
[21:40:52.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:90:0)
[21:40:52.749] Timer tick, asking Buildbucket for the build status
[21:40:52.877] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:52.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:91:0) after 1m0s
[21:41:52.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:91:0)
[21:41:52.908] Timer tick, asking Buildbucket for the build status
[21:41:53.497] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:53.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:92:0) after 1m0s
[21:42:53.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:92:0)
[21:42:53.520] Timer tick, asking Buildbucket for the build status
[21:42:53.665] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:53.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:93:0) after 1m0s
[21:43:53.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:93:0)
[21:43:53.698] Timer tick, asking Buildbucket for the build status
[21:43:53.895] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:53.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:94:0) after 1m0s
[21:44:54.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:94:0)
[21:44:54.413] Timer tick, asking Buildbucket for the build status
[21:44:54.801] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:54.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:95:0) after 1m0s
[21:45:55.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:95:0)
[21:45:55.193] Timer tick, asking Buildbucket for the build status
[21:45:55.409] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:55.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:96:0) after 1m0s
[21:46:55.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:96:0)
[21:46:55.471] Timer tick, asking Buildbucket for the build status
[21:46:55.687] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:55.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:97:0) after 1m0s
[21:47:55.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:97:0)
[21:47:55.725] Timer tick, asking Buildbucket for the build status
[21:47:55.929] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:55.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:98:0) after 1m0s
[21:48:55.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:98:0)
[21:48:55.958] Timer tick, asking Buildbucket for the build status
[21:48:56.148] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:56.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:99:0) after 1m0s
[21:49:56.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:99:0)
[21:49:56.565] Timer tick, asking Buildbucket for the build status
[21:49:56.690] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:56.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:100:0) after 1m0s
[21:50:56.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:100:0)
[21:50:56.764] Timer tick, asking Buildbucket for the build status
[21:50:56.945] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:56.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:101:0) after 1m0s
[21:51:57.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:101:0)
[21:51:57.002] Timer tick, asking Buildbucket for the build status
[21:51:57.186] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:57.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:102:0) after 1m0s
[21:52:57.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:102:0)
[21:52:57.240] Timer tick, asking Buildbucket for the build status
[21:52:57.416] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:57.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:103:0) after 1m0s
[21:53:57.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:103:0)
[21:53:57.452] Timer tick, asking Buildbucket for the build status
[21:53:58.129] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:58.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:104:0) after 1m0s
[21:54:58.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:104:0)
[21:54:58.290] Timer tick, asking Buildbucket for the build status
[21:54:58.616] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:58.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:105:0) after 1m0s
[21:55:58.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:105:0)
[21:55:58.698] Timer tick, asking Buildbucket for the build status
[21:55:58.894] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:58.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:106:0) after 1m0s
[21:56:58.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:106:0)
[21:56:58.933] Timer tick, asking Buildbucket for the build status
[21:56:59.134] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:59.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:107:0) after 1m0s
[21:57:59.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:107:0)
[21:57:59.266] Timer tick, asking Buildbucket for the build status
[21:57:59.437] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:59.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:108:0) after 1m0s
[21:58:59.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:108:0)
[21:58:59.519] Timer tick, asking Buildbucket for the build status
[21:58:59.766] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:59.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:109:0) after 1m0s
[21:59:59.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:109:0)
[21:59:59.859] Timer tick, asking Buildbucket for the build status
[22:00:00.190] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:00.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:110:0) after 1m0s
[22:01:00.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:110:0)
[22:01:00.333] Timer tick, asking Buildbucket for the build status
[22:01:00.648] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:00.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:111:0) after 1m0s
[22:02:00.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:111:0)
[22:02:00.685] Timer tick, asking Buildbucket for the build status
[22:02:00.875] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:00.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:112:0) after 1m0s
[22:03:00.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:112:0)
[22:03:00.922] Timer tick, asking Buildbucket for the build status
[22:03:01.253] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:01.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:113:0) after 1m0s
[22:04:01.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:113:0)
[22:04:01.327] Timer tick, asking Buildbucket for the build status
[22:04:02.183] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:02.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:114:0) after 1m0s
[22:05:02.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:114:0)
[22:05:02.255] Timer tick, asking Buildbucket for the build status
[22:05:03.054] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:03.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:115:0) after 1m0s
[22:06:03.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:115:0)
[22:06:03.078] Timer tick, asking Buildbucket for the build status
[22:06:03.297] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:03.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:116:0) after 1m0s
[22:07:03.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:116:0)
[22:07:03.310] Timer tick, asking Buildbucket for the build status
[22:07:03.632] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:03.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:117:0) after 1m0s
[22:08:03.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:117:0)
[22:08:03.680] Timer tick, asking Buildbucket for the build status
[22:08:03.917] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:03.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:118:0) after 1m0s
[22:09:03.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:118:0)
[22:09:03.944] Timer tick, asking Buildbucket for the build status
[22:09:04.366] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:04.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:119:0) after 1m0s
[22:10:04.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:119:0)
[22:10:04.489] Timer tick, asking Buildbucket for the build status
[22:10:04.655] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:04.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:120:0) after 1m0s
[22:11:04.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:120:0)
[22:11:04.734] Timer tick, asking Buildbucket for the build status
[22:11:05.209] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:05.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:121:0) after 1m0s
[22:12:05.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:121:0)
[22:12:05.249] Timer tick, asking Buildbucket for the build status
[22:12:06.882] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:06.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:122:0) after 1m0s
[22:13:07.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:122:0)
[22:13:07.062] Timer tick, asking Buildbucket for the build status
[22:13:07.272] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:07.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:123:0) after 1m0s
[22:14:07.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:123:0)
[22:14:07.447] Timer tick, asking Buildbucket for the build status
[22:14:07.805] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:07.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:124:0) after 1m0s
[22:15:07.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:124:0)
[22:15:07.825] Timer tick, asking Buildbucket for the build status
[22:15:08.224] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:08.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:125:0) after 1m0s
[22:16:08.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:125:0)
[22:16:08.352] Timer tick, asking Buildbucket for the build status
[22:16:08.704] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:08.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:126:0) after 1m0s
[22:17:08.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:126:0)
[22:17:08.782] Timer tick, asking Buildbucket for the build status
[22:17:09.433] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:09.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:127:0) after 1m0s
[22:18:09.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:127:0)
[22:18:09.471] Timer tick, asking Buildbucket for the build status
[22:18:09.797] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:09.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:128:0) after 1m0s
[22:19:09.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:128:0)
[22:19:09.909] Timer tick, asking Buildbucket for the build status
[22:19:10.163] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:10.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:129:0) after 1m0s
[22:20:10.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:129:0)
[22:20:10.232] Timer tick, asking Buildbucket for the build status
[22:20:10.755] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:10.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:130:0) after 1m0s
[22:21:10.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:130:0)
[22:21:10.803] Timer tick, asking Buildbucket for the build status
[22:21:11.001] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:11.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:131:0) after 1m0s
[22:22:11.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:131:0)
[22:22:11.040] Timer tick, asking Buildbucket for the build status
[22:22:11.435] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:11.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:132:0) after 1m0s
[22:23:11.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:132:0)
[22:23:11.505] Timer tick, asking Buildbucket for the build status
[22:23:11.992] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:11.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:133:0) after 1m0s
[22:24:12.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:133:0)
[22:24:12.014] Timer tick, asking Buildbucket for the build status
[22:24:12.338] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:12.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:134:0) after 1m0s
[22:25:12.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:134:0)
[22:25:12.414] Timer tick, asking Buildbucket for the build status
[22:25:12.720] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:12.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:135:0) after 1m0s
[22:26:12.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:135:0)
[22:26:12.764] Timer tick, asking Buildbucket for the build status
[22:26:12.962] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:12.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:136:0) after 1m0s
[22:27:13.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:136:0)
[22:27:13.019] Timer tick, asking Buildbucket for the build status
[22:27:13.333] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:13.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:137:0) after 1m0s
[22:28:13.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:137:0)
[22:28:13.431] Timer tick, asking Buildbucket for the build status
[22:28:13.895] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:13.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:138:0) after 1m0s
[22:29:13.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:138:0)
[22:29:13.903] Timer tick, asking Buildbucket for the build status
[22:29:14.213] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:14.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:139:0) after 1m0s
[22:30:14.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:139:0)
[22:30:14.303] Timer tick, asking Buildbucket for the build status
[22:30:14.571] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:140:0) after 1m0s
[22:31:14.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:140:0)
[22:31:14.575] Timer tick, asking Buildbucket for the build status
[22:31:14.940] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:14.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:141:0) after 1m0s
[22:32:15.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:141:0)
[22:32:15.092] Timer tick, asking Buildbucket for the build status
[22:32:15.367] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:15.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:142:0) after 1m0s
[22:33:15.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:142:0)
[22:33:15.392] Timer tick, asking Buildbucket for the build status
[22:33:15.585] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:15.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:143:0) after 1m0s
[22:34:15.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:143:0)
[22:34:15.642] Timer tick, asking Buildbucket for the build status
[22:34:15.895] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:15.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:144:0) after 1m0s
[22:35:16.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:144:0)
[22:35:16.064] Timer tick, asking Buildbucket for the build status
[22:35:16.283] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:16.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:145:0) after 1m0s
[22:36:16.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:145:0)
[22:36:16.325] Timer tick, asking Buildbucket for the build status
[22:36:16.526] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:16.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:146:0) after 1m0s
[22:37:16.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:146:0)
[22:37:16.586] Timer tick, asking Buildbucket for the build status
[22:37:17.168] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:17.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:147:0) after 1m0s
[22:38:17.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:147:0)
[22:38:17.277] Timer tick, asking Buildbucket for the build status
[22:38:17.540] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:17.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:148:0) after 1m0s
[22:39:17.539] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:148:0)
[22:39:17.539] Timer tick, asking Buildbucket for the build status
[22:39:18.238] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:18.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:149:0) after 1m0s
[22:40:18.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:149:0)
[22:40:18.316] Timer tick, asking Buildbucket for the build status
[22:40:18.484] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:18.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:150:0) after 1m0s
[22:41:18.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:150:0)
[22:41:18.510] Timer tick, asking Buildbucket for the build status
[22:41:18.675] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:18.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:151:0) after 1m0s
[22:42:18.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:151:0)
[22:42:18.709] Timer tick, asking Buildbucket for the build status
[22:42:18.883] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:18.883] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:152:0) after 1m0s
[22:43:18.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:152:0)
[22:43:18.949] Timer tick, asking Buildbucket for the build status
[22:43:19.482] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:19.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:153:0) after 1m0s
[22:44:19.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:153:0)
[22:44:19.655] Timer tick, asking Buildbucket for the build status
[22:44:19.948] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:19.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:154:0) after 1m0s
[22:45:19.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:154:0)
[22:45:19.968] Timer tick, asking Buildbucket for the build status
[22:45:20.143] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:20.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:155:0) after 1m0s
[22:46:20.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:155:0)
[22:46:20.212] Timer tick, asking Buildbucket for the build status
[22:46:20.353] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:20.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:156:0) after 1m0s
[22:47:20.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:156:0)
[22:47:20.408] Timer tick, asking Buildbucket for the build status
[22:47:20.575] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:20.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:157:0) after 1m0s
[22:48:20.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:157:0)
[22:48:20.621] Timer tick, asking Buildbucket for the build status
[22:48:20.979] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:20.979] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:158:0) after 1m0s
[22:49:21.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:158:0)
[22:49:21.108] Timer tick, asking Buildbucket for the build status
[22:49:21.614] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:21.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:159:0) after 1m0s
[22:50:21.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:159:0)
[22:50:21.726] Timer tick, asking Buildbucket for the build status
[22:50:22.075] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:22.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:160:0) after 1m0s
[22:51:22.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:160:0)
[22:51:22.134] Timer tick, asking Buildbucket for the build status
[22:51:23.049] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:23.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:161:0) after 1m0s
[22:52:23.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:161:0)
[22:52:23.068] Timer tick, asking Buildbucket for the build status
[22:52:23.942] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:23.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:162:0) after 1m0s
[22:53:24.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:162:0)
[22:53:24.025] Timer tick, asking Buildbucket for the build status
[22:53:24.378] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:24.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:163:0) after 1m0s
[22:54:24.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:163:0)
[22:54:24.402] Timer tick, asking Buildbucket for the build status
[22:54:24.582] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:24.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:164:0) after 1m0s
[22:55:24.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:164:0)
[22:55:24.600] Timer tick, asking Buildbucket for the build status
[22:55:26.357] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:26.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:165:0) after 1m0s
[22:56:26.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:165:0)
[22:56:26.354] Timer tick, asking Buildbucket for the build status
[22:56:26.757] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:26.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:166:0) after 1m0s
[22:57:26.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:166:0)
[22:57:26.836] Timer tick, asking Buildbucket for the build status
[22:57:27.433] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:27.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:167:0) after 1m0s
[22:58:27.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:167:0)
[22:58:27.540] Timer tick, asking Buildbucket for the build status
[22:58:28.260] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:28.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:168:0) after 1m0s
[22:59:28.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:168:0)
[22:59:28.307] Timer tick, asking Buildbucket for the build status
[22:59:28.879] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:28.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:169:0) after 1m0s
[23:00:28.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:169:0)
[23:00:28.964] Timer tick, asking Buildbucket for the build status
[23:00:29.461] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:29.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:170:0) after 1m0s
[23:01:29.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:170:0)
[23:01:29.489] Timer tick, asking Buildbucket for the build status
[23:01:30.138] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:30.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:171:0) after 1m0s
[23:02:30.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:171:0)
[23:02:30.287] Timer tick, asking Buildbucket for the build status
[23:02:30.564] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:30.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:172:0) after 1m0s
[23:03:30.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:172:0)
[23:03:30.708] Timer tick, asking Buildbucket for the build status
[23:03:31.104] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:31.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:173:0) after 1m0s
[23:04:31.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:173:0)
[23:04:31.132] Timer tick, asking Buildbucket for the build status
[23:04:31.577] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:31.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:174:0) after 1m0s
[23:05:31.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:174:0)
[23:05:31.650] Timer tick, asking Buildbucket for the build status
[23:05:31.819] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:31.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:175:0) after 1m0s
[23:06:31.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:175:0)
[23:06:31.845] Timer tick, asking Buildbucket for the build status
[23:06:32.143] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:32.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:176:0) after 1m0s
[23:07:32.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:176:0)
[23:07:32.278] Timer tick, asking Buildbucket for the build status
[23:07:32.648] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:32.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:177:0) after 1m0s
[23:08:32.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:177:0)
[23:08:32.719] Timer tick, asking Buildbucket for the build status
[23:08:33.677] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:33.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:178:0) after 1m0s
[23:09:33.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:178:0)
[23:09:33.749] Timer tick, asking Buildbucket for the build status
[23:09:34.469] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:179:0) after 1m0s
[23:10:34.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:179:0)
[23:10:34.585] Timer tick, asking Buildbucket for the build status
[23:10:34.779] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:34.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:180:0) after 1m0s
[23:11:34.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:180:0)
[23:11:34.863] Timer tick, asking Buildbucket for the build status
[23:11:35.453] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:35.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:181:0) after 1m0s
[23:12:35.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:181:0)
[23:12:35.495] Timer tick, asking Buildbucket for the build status
[23:12:36.007] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:36.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:182:0) after 1m0s
[23:13:36.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:182:0)
[23:13:36.174] Timer tick, asking Buildbucket for the build status
[23:13:36.357] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:36.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:183:0) after 1m0s
[23:14:36.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:183:0)
[23:14:36.393] Timer tick, asking Buildbucket for the build status
[23:14:36.560] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:36.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:184:0) after 1m0s
[23:15:36.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:184:0)
[23:15:36.840] Timer tick, asking Buildbucket for the build status
[23:15:37.063] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:37.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:185:0) after 1m0s
[23:16:37.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:185:0)
[23:16:37.168] Timer tick, asking Buildbucket for the build status
[23:16:37.387] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:37.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:186:0) after 1m0s
[23:17:37.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:186:0)
[23:17:37.547] Timer tick, asking Buildbucket for the build status
[23:17:37.704] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:37.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:187:0) after 1m0s
[23:18:38.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:187:0)
[23:18:38.081] Timer tick, asking Buildbucket for the build status
[23:18:38.262] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:38.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:188:0) after 1m0s
[23:19:38.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:188:0)
[23:19:38.676] Timer tick, asking Buildbucket for the build status
[23:19:38.955] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:38.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:189:0) after 1m0s
[23:20:39.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:189:0)
[23:20:39.372] Timer tick, asking Buildbucket for the build status
[23:20:39.687] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:39.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:190:0) after 1m0s
[23:21:39.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:190:0)
[23:21:39.786] Timer tick, asking Buildbucket for the build status
[23:21:39.943] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:39.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:191:0) after 1m0s
[23:22:39.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:191:0)
[23:22:39.989] Timer tick, asking Buildbucket for the build status
[23:22:40.677] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:40.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:192:0) after 1m0s
[23:23:40.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:192:0)
[23:23:40.728] Timer tick, asking Buildbucket for the build status
[23:23:41.636] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:41.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:193:0) after 1m0s
[23:24:41.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:193:0)
[23:24:41.628] Timer tick, asking Buildbucket for the build status
[23:24:42.136] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:42.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:194:0) after 1m0s
[23:25:42.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:194:0)
[23:25:42.285] Timer tick, asking Buildbucket for the build status
[23:25:42.698] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:42.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:195:0) after 1m0s
[23:26:42.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:195:0)
[23:26:42.750] Timer tick, asking Buildbucket for the build status
[23:26:42.939] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:42.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:196:0) after 1m0s
[23:27:42.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:196:0)
[23:27:42.927] Timer tick, asking Buildbucket for the build status
[23:27:43.654] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:43.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:197:0) after 1m0s
[23:28:43.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:197:0)
[23:28:43.687] Timer tick, asking Buildbucket for the build status
[23:28:43.913] Build 8892616842755720912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:43.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058046904755574720:198:0) after 1m0s
[23:28:51.205] Received PubSub notification, asking Buildbucket for the build status
[23:28:51.601] Build 8892616842755720912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:28:51.601] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577748529176563",
"created_by": "project:chromium",
"created_ts": "1577736733630301",
"id": "8892616842755720912",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e9c7d5b750c3d2a541672505fd3a1a67dc93792\"}}",
"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-f4j7\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15589, \"got_angle_revision\": \"9fac1817ede6b2f1dc61468e2625cbc30d35077c\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"6e9c7d5b750c3d2a541672505fd3a1a67dc93792\", \"got_revision_cp\": \"refs/heads/master@{#727790}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"59465799210b3f4962af1a9dc44a4ffecb422c10\", \"got_v8_revision\": \"4c53f9a51444393133ff303952f1296603d44ab7\", \"got_v8_revision_cp\": \"refs/heads/8.1.80@{#1}\", \"got_webrtc_revision\": \"9d2c2dba28656b3c913797daaf99b8bf56ca6103\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30128}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6e9c7d5b750c3d2a541672505fd3a1a67dc93792\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-f4j7\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4733-6bd8c41\"], \"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": "1577736740828895",
"status": "COMPLETED",
"status_changed_ts": "1577748530455365",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15589",
"builder:Windows deterministic",
"buildset:commit/git/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6e9c7d5b750c3d2a541672505fd3a1a67dc93792",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058046904755574720",
"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/8892616842755720912/+/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:4971419483145210",
"user_agent:luci-scheduler"
],
"updated_ts": "1577748530537209",
"url": "https://ci.chromium.org/b/8892616842755720912",
"utcnow_ts": "1577748531593448"
}
}
[23:28:51.601] Invocation finished in 3h16m39.261660267s with status SUCCEEDED