[21:44:58.526] New invocation is queued and will start shortly
[21:45:02.701] Starting the invocation (attempt 1)
[21:45:02.801] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:45:02.801] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:45:02.801] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065923004293872464",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"cc50a16277cd9821c2159090e0fd8818849aa1b0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9065923004293872464",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"gitiles_ref:refs/heads/master"
]
}
[21:45:03.889] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570225503048024",
"id": "8900492938873726736",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cc50a16277cd9821c2159090e0fd8818849aa1b0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570225503600052",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14888",
"builder:Windows deterministic",
"buildset:commit/git/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065923004293872464",
"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/8900492938873726736/+/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": "1570225503600178",
"url": "https://ci.chromium.org/b/8900492938873726736",
"utcnow_ts": "1570225503880598"
}
}
[21:45:03.889] Task URL: https://ci.chromium.org/b/8900492938873726736
[21:45:03.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:2:0) after 1m0s
[21:45:50.298] Received PubSub notification, asking Buildbucket for the build status
[21:45:52.631] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:03.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:2:0)
[21:46:03.953] Timer tick, asking Buildbucket for the build status
[21:46:04.127] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:04.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:4:0) after 1m0s
[21:47:04.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:4:0)
[21:47:04.229] Timer tick, asking Buildbucket for the build status
[21:47:04.422] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:04.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:5:0) after 1m0s
[21:48:04.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:5:0)
[21:48:04.621] Timer tick, asking Buildbucket for the build status
[21:48:04.971] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:04.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:6:0) after 1m0s
[21:49:05.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:6:0)
[21:49:05.075] Timer tick, asking Buildbucket for the build status
[21:49:05.303] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:05.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:7:0) after 1m0s
[21:50:05.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:7:0)
[21:50:05.335] Timer tick, asking Buildbucket for the build status
[21:50:05.565] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:05.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:8:0) after 1m0s
[21:51:05.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:8:0)
[21:51:05.677] Timer tick, asking Buildbucket for the build status
[21:51:11.267] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:11.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:9:0) after 1m0s
[21:52:11.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:9:0)
[21:52:11.346] Timer tick, asking Buildbucket for the build status
[21:52:12.224] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:12.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:10:0) after 1m0s
[21:53:12.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:10:0)
[21:53:12.306] Timer tick, asking Buildbucket for the build status
[21:53:13.017] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:13.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:11:0) after 1m0s
[21:54:13.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:11:0)
[21:54:13.180] Timer tick, asking Buildbucket for the build status
[21:54:13.460] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:12:0) after 1m0s
[21:55:13.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:12:0)
[21:55:13.532] Timer tick, asking Buildbucket for the build status
[21:55:14.732] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:14.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:13:0) after 1m0s
[21:56:14.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:13:0)
[21:56:14.794] Timer tick, asking Buildbucket for the build status
[21:56:16.049] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:16.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:14:0) after 1m0s
[21:57:16.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:14:0)
[21:57:16.154] Timer tick, asking Buildbucket for the build status
[21:57:16.380] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:16.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:15:0) after 1m0s
[21:58:16.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:15:0)
[21:58:16.441] Timer tick, asking Buildbucket for the build status
[21:58:18.293] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:18.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:16:0) after 1m0s
[21:59:18.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:16:0)
[21:59:18.335] Timer tick, asking Buildbucket for the build status
[21:59:18.482] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:18.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:17:0) after 1m0s
[22:00:18.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:17:0)
[22:00:18.701] Timer tick, asking Buildbucket for the build status
[22:00:18.929] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:18.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:18:0) after 1m0s
[22:01:19.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:18:0)
[22:01:19.004] Timer tick, asking Buildbucket for the build status
[22:01:19.531] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:19:0) after 1m0s
[22:02:19.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:19:0)
[22:02:19.652] Timer tick, asking Buildbucket for the build status
[22:02:20.453] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:20.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:20:0) after 1m0s
[22:03:20.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:20:0)
[22:03:20.526] Timer tick, asking Buildbucket for the build status
[22:03:20.700] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:21:0) after 1m0s
[22:04:20.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:21:0)
[22:04:20.773] Timer tick, asking Buildbucket for the build status
[22:04:22.225] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:22.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:22:0) after 1m0s
[22:05:22.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:22:0)
[22:05:22.378] Timer tick, asking Buildbucket for the build status
[22:05:23.082] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:23.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:23:0) after 1m0s
[22:06:23.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:23:0)
[22:06:23.212] Timer tick, asking Buildbucket for the build status
[22:06:23.634] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:23.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:24:0) after 1m0s
[22:07:23.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:24:0)
[22:07:23.738] Timer tick, asking Buildbucket for the build status
[22:07:23.981] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:23.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:25:0) after 1m0s
[22:08:24.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:25:0)
[22:08:24.185] Timer tick, asking Buildbucket for the build status
[22:08:24.450] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:24.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:26:0) after 1m0s
[22:09:24.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:26:0)
[22:09:24.546] Timer tick, asking Buildbucket for the build status
[22:09:24.713] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:24.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:27:0) after 1m0s
[22:10:24.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:27:0)
[22:10:24.873] Timer tick, asking Buildbucket for the build status
[22:10:25.246] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:25.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:28:0) after 1m0s
[22:11:25.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:28:0)
[22:11:25.349] Timer tick, asking Buildbucket for the build status
[22:11:25.605] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:25.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:29:0) after 1m0s
[22:12:25.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:29:0)
[22:12:25.646] Timer tick, asking Buildbucket for the build status
[22:12:26.725] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:26.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:30:0) after 1m0s
[22:13:26.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:30:0)
[22:13:26.814] Timer tick, asking Buildbucket for the build status
[22:13:26.952] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:26.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:31:0) after 1m0s
[22:14:26.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:31:0)
[22:14:26.984] Timer tick, asking Buildbucket for the build status
[22:14:27.180] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:27.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:32:0) after 1m0s
[22:15:27.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:32:0)
[22:15:27.187] Timer tick, asking Buildbucket for the build status
[22:15:31.088] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:33:0) after 1m0s
[22:16:31.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:33:0)
[22:16:31.374] Timer tick, asking Buildbucket for the build status
[22:16:31.596] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:31.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:34:0) after 1m0s
[22:17:31.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:34:0)
[22:17:31.655] Timer tick, asking Buildbucket for the build status
[22:17:31.826] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:31.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:35:0) after 1m0s
[22:18:31.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:35:0)
[22:18:31.965] Timer tick, asking Buildbucket for the build status
[22:18:33.519] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:36:0) after 1m0s
[22:19:33.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:36:0)
[22:19:33.592] Timer tick, asking Buildbucket for the build status
[22:19:35.414] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:35.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:37:0) after 1m0s
[22:20:35.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:37:0)
[22:20:35.400] Timer tick, asking Buildbucket for the build status
[22:20:35.752] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:35.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:38:0) after 1m0s
[22:21:36.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:38:0)
[22:21:36.022] Timer tick, asking Buildbucket for the build status
[22:21:36.295] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:39:0) after 1m0s
[22:22:36.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:39:0)
[22:22:36.355] Timer tick, asking Buildbucket for the build status
[22:22:36.512] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:36.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:40:0) after 1m0s
[22:23:36.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:40:0)
[22:23:36.557] Timer tick, asking Buildbucket for the build status
[22:23:37.009] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:37.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:41:0) after 1m0s
[22:24:37.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:41:0)
[22:24:37.108] Timer tick, asking Buildbucket for the build status
[22:24:37.307] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:37.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:42:0) after 1m0s
[22:25:37.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:42:0)
[22:25:37.350] Timer tick, asking Buildbucket for the build status
[22:25:37.526] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:37.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:43:0) after 1m0s
[22:26:37.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:43:0)
[22:26:37.596] Timer tick, asking Buildbucket for the build status
[22:26:37.849] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:37.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:44:0) after 1m0s
[22:27:37.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:44:0)
[22:27:37.871] Timer tick, asking Buildbucket for the build status
[22:27:38.068] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:45:0) after 1m0s
[22:28:38.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:45:0)
[22:28:38.277] Timer tick, asking Buildbucket for the build status
[22:28:39.214] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:39.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:46:0) after 1m0s
[22:29:39.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:46:0)
[22:29:39.303] Timer tick, asking Buildbucket for the build status
[22:29:40.898] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:40.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:47:0) after 1m0s
[22:30:40.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:47:0)
[22:30:40.983] Timer tick, asking Buildbucket for the build status
[22:30:42.234] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:42.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:48:0) after 1m0s
[22:31:42.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:48:0)
[22:31:42.432] Timer tick, asking Buildbucket for the build status
[22:31:42.934] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:42.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:49:0) after 1m0s
[22:32:43.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:49:0)
[22:32:43.007] Timer tick, asking Buildbucket for the build status
[22:32:43.750] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:43.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:50:0) after 1m0s
[22:33:43.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:50:0)
[22:33:43.867] Timer tick, asking Buildbucket for the build status
[22:33:44.215] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:44.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:51:0) after 1m0s
[22:34:44.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:51:0)
[22:34:44.335] Timer tick, asking Buildbucket for the build status
[22:34:44.698] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:44.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:52:0) after 1m0s
[22:35:44.768] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:52:0)
[22:35:44.768] Timer tick, asking Buildbucket for the build status
[22:35:45.190] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:45.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:53:0) after 1m0s
[22:36:45.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:53:0)
[22:36:45.239] Timer tick, asking Buildbucket for the build status
[22:36:45.457] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:45.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:54:0) after 1m0s
[22:37:45.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:54:0)
[22:37:45.565] Timer tick, asking Buildbucket for the build status
[22:37:46.483] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:46.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:55:0) after 1m0s
[22:38:46.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:55:0)
[22:38:46.568] Timer tick, asking Buildbucket for the build status
[22:38:46.994] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:46.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:56:0) after 1m0s
[22:39:47.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:56:0)
[22:39:47.155] Timer tick, asking Buildbucket for the build status
[22:39:47.493] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:47.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:57:0) after 1m0s
[22:40:47.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:57:0)
[22:40:47.618] Timer tick, asking Buildbucket for the build status
[22:40:49.049] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:49.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:58:0) after 1m0s
[22:41:49.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:58:0)
[22:41:49.169] Timer tick, asking Buildbucket for the build status
[22:41:50.730] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:50.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:59:0) after 1m0s
[22:42:50.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:59:0)
[22:42:50.866] Timer tick, asking Buildbucket for the build status
[22:42:50.992] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:50.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:60:0) after 1m0s
[22:43:51.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:60:0)
[22:43:51.076] Timer tick, asking Buildbucket for the build status
[22:43:51.236] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:51.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:61:0) after 1m0s
[22:44:51.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:61:0)
[22:44:51.349] Timer tick, asking Buildbucket for the build status
[22:44:51.606] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:51.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:62:0) after 1m0s
[22:45:51.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:62:0)
[22:45:51.815] Timer tick, asking Buildbucket for the build status
[22:45:52.341] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:52.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:63:0) after 1m0s
[22:46:52.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:63:0)
[22:46:52.512] Timer tick, asking Buildbucket for the build status
[22:46:52.673] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:52.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:64:0) after 1m0s
[22:47:52.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:64:0)
[22:47:52.807] Timer tick, asking Buildbucket for the build status
[22:47:53.044] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:53.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:65:0) after 1m0s
[22:48:53.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:65:0)
[22:48:53.114] Timer tick, asking Buildbucket for the build status
[22:48:53.308] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:53.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:66:0) after 1m0s
[22:49:53.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:66:0)
[22:49:53.505] Timer tick, asking Buildbucket for the build status
[22:49:54.032] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:54.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:67:0) after 1m0s
[22:50:54.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:67:0)
[22:50:54.044] Timer tick, asking Buildbucket for the build status
[22:50:54.994] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:54.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:68:0) after 1m0s
[22:51:55.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:68:0)
[22:51:55.125] Timer tick, asking Buildbucket for the build status
[22:51:56.446] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:56.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:69:0) after 1m0s
[22:52:56.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:69:0)
[22:52:56.431] Timer tick, asking Buildbucket for the build status
[22:52:57.147] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:57.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:70:0) after 1m0s
[22:53:57.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:70:0)
[22:53:57.178] Timer tick, asking Buildbucket for the build status
[22:53:57.484] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:57.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:71:0) after 1m0s
[22:54:57.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:71:0)
[22:54:57.557] Timer tick, asking Buildbucket for the build status
[22:54:57.886] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:57.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:72:0) after 1m0s
[22:55:58.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:72:0)
[22:55:58.054] Timer tick, asking Buildbucket for the build status
[22:55:58.920] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:58.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:73:0) after 1m0s
[22:56:59.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:73:0)
[22:56:59.009] Timer tick, asking Buildbucket for the build status
[22:57:01.958] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:01.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:74:0) after 1m0s
[22:58:02.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:74:0)
[22:58:02.028] Timer tick, asking Buildbucket for the build status
[22:58:02.631] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:02.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:75:0) after 1m0s
[22:59:02.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:75:0)
[22:59:02.675] Timer tick, asking Buildbucket for the build status
[22:59:04.028] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:04.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:76:0) after 1m0s
[23:00:04.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:76:0)
[23:00:04.140] Timer tick, asking Buildbucket for the build status
[23:00:06.701] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:06.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:77:0) after 1m0s
[23:01:06.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:77:0)
[23:01:06.805] Timer tick, asking Buildbucket for the build status
[23:01:07.094] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:07.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:78:0) after 1m0s
[23:02:07.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:78:0)
[23:02:07.165] Timer tick, asking Buildbucket for the build status
[23:02:09.941] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:09.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:79:0) after 1m0s
[23:03:10.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:79:0)
[23:03:10.042] Timer tick, asking Buildbucket for the build status
[23:03:10.500] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:10.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:80:0) after 1m0s
[23:04:10.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:80:0)
[23:04:10.619] Timer tick, asking Buildbucket for the build status
[23:04:10.876] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:10.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:81:0) after 1m0s
[23:05:10.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:81:0)
[23:05:10.902] Timer tick, asking Buildbucket for the build status
[23:05:12.813] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:12.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:82:0) after 1m0s
[23:06:12.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:82:0)
[23:06:12.913] Timer tick, asking Buildbucket for the build status
[23:06:13.873] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:13.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:83:0) after 1m0s
[23:07:13.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:83:0)
[23:07:13.975] Timer tick, asking Buildbucket for the build status
[23:07:14.297] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:14.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:84:0) after 1m0s
[23:08:14.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:84:0)
[23:08:14.399] Timer tick, asking Buildbucket for the build status
[23:08:17.766] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:17.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:85:0) after 1m0s
[23:09:17.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:85:0)
[23:09:17.836] Timer tick, asking Buildbucket for the build status
[23:09:21.729] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:21.729] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:86:0) after 1m0s
[23:10:21.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:86:0)
[23:10:21.797] Timer tick, asking Buildbucket for the build status
[23:10:22.370] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:22.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:87:0) after 1m0s
[23:11:22.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:87:0)
[23:11:22.580] Timer tick, asking Buildbucket for the build status
[23:11:23.133] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:23.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:88:0) after 1m0s
[23:12:23.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:88:0)
[23:12:23.218] Timer tick, asking Buildbucket for the build status
[23:12:24.101] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:24.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:89:0) after 1m0s
[23:13:24.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:89:0)
[23:13:24.117] Timer tick, asking Buildbucket for the build status
[23:13:24.307] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:24.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:90:0) after 1m0s
[23:14:24.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:90:0)
[23:14:24.365] Timer tick, asking Buildbucket for the build status
[23:14:24.687] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:24.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:91:0) after 1m0s
[23:15:24.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:91:0)
[23:15:24.765] Timer tick, asking Buildbucket for the build status
[23:15:25.409] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:25.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:92:0) after 1m0s
[23:16:25.467] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:92:0)
[23:16:25.467] Timer tick, asking Buildbucket for the build status
[23:16:25.727] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:25.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:93:0) after 1m0s
[23:17:25.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:93:0)
[23:17:25.738] Timer tick, asking Buildbucket for the build status
[23:17:26.533] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:26.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:94:0) after 1m0s
[23:18:26.606] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:94:0)
[23:18:26.606] Timer tick, asking Buildbucket for the build status
[23:18:26.807] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:26.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:95:0) after 1m0s
[23:19:26.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:95:0)
[23:19:26.875] Timer tick, asking Buildbucket for the build status
[23:19:27.100] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:27.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:96:0) after 1m0s
[23:20:27.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:96:0)
[23:20:27.180] Timer tick, asking Buildbucket for the build status
[23:20:27.434] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:27.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:97:0) after 1m0s
[23:21:27.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:97:0)
[23:21:27.499] Timer tick, asking Buildbucket for the build status
[23:21:27.622] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:27.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:98:0) after 1m0s
[23:22:27.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:98:0)
[23:22:27.697] Timer tick, asking Buildbucket for the build status
[23:22:29.110] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:29.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:99:0) after 1m0s
[23:23:29.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:99:0)
[23:23:29.164] Timer tick, asking Buildbucket for the build status
[23:23:29.420] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:29.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:100:0) after 1m0s
[23:24:29.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:100:0)
[23:24:29.510] Timer tick, asking Buildbucket for the build status
[23:24:29.786] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:29.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:101:0) after 1m0s
[23:25:29.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:101:0)
[23:25:29.866] Timer tick, asking Buildbucket for the build status
[23:25:30.130] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:30.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:102:0) after 1m0s
[23:26:30.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:102:0)
[23:26:30.252] Timer tick, asking Buildbucket for the build status
[23:26:30.468] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:30.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:103:0) after 1m0s
[23:27:30.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:103:0)
[23:27:30.546] Timer tick, asking Buildbucket for the build status
[23:27:30.699] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:30.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:104:0) after 1m0s
[23:28:30.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:104:0)
[23:28:30.886] Timer tick, asking Buildbucket for the build status
[23:28:31.804] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:31.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:105:0) after 1m0s
[23:29:31.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:105:0)
[23:29:31.893] Timer tick, asking Buildbucket for the build status
[23:29:32.110] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:32.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:106:0) after 1m0s
[23:30:32.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:106:0)
[23:30:32.290] Timer tick, asking Buildbucket for the build status
[23:30:32.437] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:32.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:107:0) after 1m0s
[23:31:32.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:107:0)
[23:31:32.686] Timer tick, asking Buildbucket for the build status
[23:31:36.733] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:36.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:108:0) after 1m0s
[23:32:36.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:108:0)
[23:32:36.787] Timer tick, asking Buildbucket for the build status
[23:32:37.450] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:37.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:109:0) after 1m0s
[23:33:37.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:109:0)
[23:33:37.547] Timer tick, asking Buildbucket for the build status
[23:33:37.876] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:37.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:110:0) after 1m0s
[23:34:37.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:110:0)
[23:34:37.939] Timer tick, asking Buildbucket for the build status
[23:34:38.146] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:38.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:111:0) after 1m0s
[23:35:38.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:111:0)
[23:35:38.293] Timer tick, asking Buildbucket for the build status
[23:35:38.781] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:38.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:112:0) after 1m0s
[23:36:38.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:112:0)
[23:36:38.957] Timer tick, asking Buildbucket for the build status
[23:36:40.510] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:40.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:113:0) after 1m0s
[23:37:40.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:113:0)
[23:37:40.553] Timer tick, asking Buildbucket for the build status
[23:37:42.631] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:42.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:114:0) after 1m0s
[23:38:42.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:114:0)
[23:38:42.702] Timer tick, asking Buildbucket for the build status
[23:38:43.157] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:43.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:115:0) after 1m0s
[23:39:43.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:115:0)
[23:39:43.201] Timer tick, asking Buildbucket for the build status
[23:39:43.463] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:43.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:116:0) after 1m0s
[23:40:43.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:116:0)
[23:40:43.507] Timer tick, asking Buildbucket for the build status
[23:40:43.747] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:43.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:117:0) after 1m0s
[23:41:43.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:117:0)
[23:41:43.823] Timer tick, asking Buildbucket for the build status
[23:41:44.234] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:44.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:118:0) after 1m0s
[23:42:44.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:118:0)
[23:42:44.270] Timer tick, asking Buildbucket for the build status
[23:42:44.547] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:44.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:119:0) after 1m0s
[23:43:44.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:119:0)
[23:43:44.622] Timer tick, asking Buildbucket for the build status
[23:43:46.122] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:46.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:120:0) after 1m0s
[23:44:46.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:120:0)
[23:44:46.173] Timer tick, asking Buildbucket for the build status
[23:44:46.390] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:46.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:121:0) after 1m0s
[23:45:46.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:121:0)
[23:45:46.474] Timer tick, asking Buildbucket for the build status
[23:45:46.868] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:46.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:122:0) after 1m0s
[23:46:46.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:122:0)
[23:46:46.906] Timer tick, asking Buildbucket for the build status
[23:46:47.112] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:47.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:123:0) after 1m0s
[23:47:47.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:123:0)
[23:47:47.230] Timer tick, asking Buildbucket for the build status
[23:47:47.457] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:47.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:124:0) after 1m0s
[23:48:47.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:124:0)
[23:48:47.541] Timer tick, asking Buildbucket for the build status
[23:48:48.013] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:48.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:125:0) after 1m0s
[23:49:48.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:125:0)
[23:49:48.063] Timer tick, asking Buildbucket for the build status
[23:49:48.325] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:48.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:126:0) after 1m0s
[23:50:48.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:126:0)
[23:50:48.469] Timer tick, asking Buildbucket for the build status
[23:50:48.698] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:48.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:127:0) after 1m0s
[23:51:49.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:127:0)
[23:51:49.046] Timer tick, asking Buildbucket for the build status
[23:51:49.841] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:49.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:128:0) after 1m0s
[23:52:49.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:128:0)
[23:52:49.903] Timer tick, asking Buildbucket for the build status
[23:52:50.490] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:50.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:129:0) after 1m0s
[23:53:50.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:129:0)
[23:53:50.726] Timer tick, asking Buildbucket for the build status
[23:53:51.054] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:51.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:130:0) after 1m0s
[23:54:51.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:130:0)
[23:54:51.174] Timer tick, asking Buildbucket for the build status
[23:54:51.424] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:51.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:131:0) after 1m0s
[23:55:51.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:131:0)
[23:55:51.486] Timer tick, asking Buildbucket for the build status
[23:55:52.314] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:52.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:132:0) after 1m0s
[23:56:52.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:132:0)
[23:56:52.372] Timer tick, asking Buildbucket for the build status
[23:56:53.321] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:53.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:133:0) after 1m0s
[23:57:53.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:133:0)
[23:57:53.390] Timer tick, asking Buildbucket for the build status
[23:57:53.571] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:53.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:134:0) after 1m0s
[23:58:53.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:134:0)
[23:58:53.617] Timer tick, asking Buildbucket for the build status
[23:58:54.424] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:54.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:135:0) after 1m0s
[23:59:54.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:135:0)
[23:59:54.614] Timer tick, asking Buildbucket for the build status
[23:59:55.151] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:55.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:136:0) after 1m0s
[00:00:55.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:136:0)
[00:00:55.416] Timer tick, asking Buildbucket for the build status
[00:00:58.176] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:58.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:137:0) after 1m0s
[00:01:58.364] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:137:0)
[00:01:58.364] Timer tick, asking Buildbucket for the build status
[00:01:59.699] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:59.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:138:0) after 1m0s
[00:02:59.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:138:0)
[00:02:59.737] Timer tick, asking Buildbucket for the build status
[00:03:00.313] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:00.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:139:0) after 1m0s
[00:04:00.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:139:0)
[00:04:00.499] Timer tick, asking Buildbucket for the build status
[00:04:01.002] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:01.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:140:0) after 1m0s
[00:05:01.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:140:0)
[00:05:01.081] Timer tick, asking Buildbucket for the build status
[00:05:02.025] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:02.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:141:0) after 1m0s
[00:06:02.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:141:0)
[00:06:02.208] Timer tick, asking Buildbucket for the build status
[00:06:02.524] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:02.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:142:0) after 1m0s
[00:07:02.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:142:0)
[00:07:02.701] Timer tick, asking Buildbucket for the build status
[00:07:03.578] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:03.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:143:0) after 1m0s
[00:08:03.619] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:143:0)
[00:08:03.619] Timer tick, asking Buildbucket for the build status
[00:08:03.818] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:03.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:144:0) after 1m0s
[00:09:04.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:144:0)
[00:09:04.039] Timer tick, asking Buildbucket for the build status
[00:09:04.751] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:04.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:145:0) after 1m0s
[00:10:04.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:145:0)
[00:10:04.990] Timer tick, asking Buildbucket for the build status
[00:10:05.306] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:05.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:146:0) after 1m0s
[00:11:05.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:146:0)
[00:11:05.498] Timer tick, asking Buildbucket for the build status
[00:11:05.697] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:05.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:147:0) after 1m0s
[00:12:05.982] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:147:0)
[00:12:05.982] Timer tick, asking Buildbucket for the build status
[00:12:06.312] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:06.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:148:0) after 1m0s
[00:13:06.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:148:0)
[00:13:06.393] Timer tick, asking Buildbucket for the build status
[00:13:07.832] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:07.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:149:0) after 1m0s
[00:14:07.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:149:0)
[00:14:07.939] Timer tick, asking Buildbucket for the build status
[00:14:08.255] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:08.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:150:0) after 1m0s
[00:15:08.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:150:0)
[00:15:08.380] Timer tick, asking Buildbucket for the build status
[00:15:08.841] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:08.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:151:0) after 1m0s
[00:16:08.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:151:0)
[00:16:08.983] Timer tick, asking Buildbucket for the build status
[00:16:09.318] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:09.318] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:152:0) after 1m0s
[00:17:09.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:152:0)
[00:17:09.400] Timer tick, asking Buildbucket for the build status
[00:17:09.635] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:09.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:153:0) after 1m0s
[00:18:09.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:153:0)
[00:18:09.639] Timer tick, asking Buildbucket for the build status
[00:18:09.893] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:09.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:154:0) after 1m0s
[00:19:09.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:154:0)
[00:19:09.950] Timer tick, asking Buildbucket for the build status
[00:19:10.389] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:10.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:155:0) after 1m0s
[00:20:10.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:155:0)
[00:20:10.501] Timer tick, asking Buildbucket for the build status
[00:20:10.687] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:10.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:156:0) after 1m0s
[00:21:10.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:156:0)
[00:21:10.987] Timer tick, asking Buildbucket for the build status
[00:21:11.877] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:11.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:157:0) after 1m0s
[00:22:12.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:157:0)
[00:22:12.205] Timer tick, asking Buildbucket for the build status
[00:22:14.265] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:14.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:158:0) after 1m0s
[00:23:14.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:158:0)
[00:23:14.936] Timer tick, asking Buildbucket for the build status
[00:23:15.511] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:15.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:159:0) after 1m0s
[00:24:15.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:159:0)
[00:24:15.867] Timer tick, asking Buildbucket for the build status
[00:24:16.547] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:16.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:160:0) after 1m0s
[00:25:16.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:160:0)
[00:25:16.654] Timer tick, asking Buildbucket for the build status
[00:25:19.793] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:19.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:161:0) after 1m0s
[00:26:19.914] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:161:0)
[00:26:19.914] Timer tick, asking Buildbucket for the build status
[00:26:21.222] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:21.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:162:0) after 1m0s
[00:27:21.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:162:0)
[00:27:21.231] Timer tick, asking Buildbucket for the build status
[00:27:25.320] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:25.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:163:0) after 1m0s
[00:28:25.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:163:0)
[00:28:25.402] Timer tick, asking Buildbucket for the build status
[00:28:26.329] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:26.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:164:0) after 1m0s
[00:29:26.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:164:0)
[00:29:26.403] Timer tick, asking Buildbucket for the build status
[00:29:27.646] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:27.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:165:0) after 1m0s
[00:30:27.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:165:0)
[00:30:27.851] Timer tick, asking Buildbucket for the build status
[00:30:28.689] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:166:0) after 1m0s
[00:31:28.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:166:0)
[00:31:28.860] Timer tick, asking Buildbucket for the build status
[00:31:29.125] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:29.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:167:0) after 1m0s
[00:32:29.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:167:0)
[00:32:29.164] Timer tick, asking Buildbucket for the build status
[00:32:30.073] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:30.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:168:0) after 1m0s
[00:33:30.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:168:0)
[00:33:30.122] Timer tick, asking Buildbucket for the build status
[00:33:32.226] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:32.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:169:0) after 1m0s
[00:34:32.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:169:0)
[00:34:32.324] Timer tick, asking Buildbucket for the build status
[00:34:32.754] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:32.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:170:0) after 1m0s
[00:35:32.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:170:0)
[00:35:32.839] Timer tick, asking Buildbucket for the build status
[00:35:33.758] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:33.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:171:0) after 1m0s
[00:36:33.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:171:0)
[00:36:33.830] Timer tick, asking Buildbucket for the build status
[00:36:37.546] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:37.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:172:0) after 1m0s
[00:37:37.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:172:0)
[00:37:37.686] Timer tick, asking Buildbucket for the build status
[00:37:38.142] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:38.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:173:0) after 1m0s
[00:38:38.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:173:0)
[00:38:38.236] Timer tick, asking Buildbucket for the build status
[00:38:39.651] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:174:0) after 1m0s
[00:39:39.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:174:0)
[00:39:39.750] Timer tick, asking Buildbucket for the build status
[00:39:39.970] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:39.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:175:0) after 1m0s
[00:40:40.080] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:175:0)
[00:40:40.080] Timer tick, asking Buildbucket for the build status
[00:40:40.458] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:40.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:176:0) after 1m0s
[00:41:40.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:176:0)
[00:41:40.702] Timer tick, asking Buildbucket for the build status
[00:41:41.460] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:41.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:177:0) after 1m0s
[00:42:41.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:177:0)
[00:42:41.639] Timer tick, asking Buildbucket for the build status
[00:42:42.315] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:42.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:178:0) after 1m0s
[00:43:42.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:178:0)
[00:43:42.398] Timer tick, asking Buildbucket for the build status
[00:43:42.580] Build 8900492938873726736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:42.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065923004293872464:179:0) after 1m0s
[00:44:16.233] Received PubSub notification, asking Buildbucket for the build status
[00:44:16.352] Build 8900492938873726736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:44:16.352] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570236255044021",
"created_by": "project:chromium",
"created_ts": "1570225503048024",
"id": "8900492938873726736",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cc50a16277cd9821c2159090e0fd8818849aa1b0\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-kun4\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14888, \"got_angle_revision\": \"6b60dfd80e3dc3fe13eb1b9bcaf8b36f30e20b45\", \"got_dawn_revision\": \"21dfc919547fb3b139b56271d1aa09518bd75801\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"cc50a16277cd9821c2159090e0fd8818849aa1b0\", \"got_revision_cp\": \"refs/heads/master@{#703050}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"395b9e4a0479a0a4752ecabeaf492afce808072f\", \"got_v8_revision_cp\": \"refs/heads/7.9.214@{#1}\", \"got_webrtc_revision\": \"7536bc539500b44a7c4ebf7d8e7fd9ef474c3fae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29382}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cc50a16277cd9821c2159090e0fd8818849aa1b0\"}, \"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-kun4\"], \"image\": [\"chrome-win10-1703-19091300-a244b1e46d2\"], \"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\": [\"4466-755d6a2\"], \"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": "1570225549530947",
"status": "COMPLETED",
"status_changed_ts": "1570236255605193",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14888",
"builder:Windows deterministic",
"buildset:commit/git/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc50a16277cd9821c2159090e0fd8818849aa1b0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065923004293872464",
"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/8900492938873726736/+/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:47b18db2d7305010",
"user_agent:luci-scheduler"
],
"updated_ts": "1570236255681733",
"url": "https://ci.chromium.org/b/8900492938873726736",
"utcnow_ts": "1570236256346011"
}
}
[00:44:16.352] Invocation finished in 2h59m17.855685515s with status SUCCEEDED