[21:07:05.560] New invocation is queued and will start shortly
[21:07:06.651] Starting the invocation (attempt 1)
[21:07:06.730] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:07:06.731] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:07:06.731] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9065381805860591264",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"56ef4cb6fce4972f8b94fdfba561b891d92f4d78\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9065381805860591264",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"gitiles_ref:refs/heads/master"
]
}
[21:07:11.828] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1570741628775477",
"id": "8899951741823782272",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56ef4cb6fce4972f8b94fdfba561b891d92f4d78\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1570741630896157",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14938",
"builder:Windows deterministic",
"buildset:commit/git/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065381805860591264",
"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/8899951741823782272/+/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": "1570741630896314",
"url": "https://ci.chromium.org/b/8899951741823782272",
"utcnow_ts": "1570741631759934"
}
}
[21:07:11.828] Task URL: https://ci.chromium.org/b/8899951741823782272
[21:07:11.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:2:0) after 1m0s
[21:07:59.715] Received PubSub notification, asking Buildbucket for the build status
[21:07:59.853] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:11.931] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:2:0)
[21:08:11.931] Timer tick, asking Buildbucket for the build status
[21:08:12.599] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:12.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:4:0) after 1m0s
[21:09:12.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:4:0)
[21:09:12.794] Timer tick, asking Buildbucket for the build status
[21:09:13.012] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:13.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:5:0) after 1m0s
[21:10:13.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:5:0)
[21:10:13.155] Timer tick, asking Buildbucket for the build status
[21:10:13.362] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:13.362] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:6:0) after 1m0s
[21:11:13.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:6:0)
[21:11:13.540] Timer tick, asking Buildbucket for the build status
[21:11:13.808] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:13.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:7:0) after 1m0s
[21:12:13.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:7:0)
[21:12:13.841] Timer tick, asking Buildbucket for the build status
[21:12:14.203] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:14.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:8:0) after 1m0s
[21:13:14.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:8:0)
[21:13:14.231] Timer tick, asking Buildbucket for the build status
[21:13:15.549] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:15.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:9:0) after 1m0s
[21:14:15.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:9:0)
[21:14:15.700] Timer tick, asking Buildbucket for the build status
[21:14:17.600] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:17.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:10:0) after 1m0s
[21:15:17.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:10:0)
[21:15:17.681] Timer tick, asking Buildbucket for the build status
[21:15:18.664] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:18.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:11:0) after 1m0s
[21:16:18.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:11:0)
[21:16:18.812] Timer tick, asking Buildbucket for the build status
[21:16:19.057] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:19.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:12:0) after 1m0s
[21:17:19.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:12:0)
[21:17:19.281] Timer tick, asking Buildbucket for the build status
[21:17:19.555] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:19.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:13:0) after 1m0s
[21:18:19.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:13:0)
[21:18:19.562] Timer tick, asking Buildbucket for the build status
[21:18:20.261] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:20.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:14:0) after 1m0s
[21:19:20.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:14:0)
[21:19:20.326] Timer tick, asking Buildbucket for the build status
[21:19:20.995] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:20.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:15:0) after 1m0s
[21:20:21.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:15:0)
[21:20:21.142] Timer tick, asking Buildbucket for the build status
[21:20:21.495] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:21.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:16:0) after 1m0s
[21:21:21.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:16:0)
[21:21:21.616] Timer tick, asking Buildbucket for the build status
[21:21:25.593] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:25.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:17:0) after 1m0s
[21:22:25.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:17:0)
[21:22:25.671] Timer tick, asking Buildbucket for the build status
[21:22:25.948] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:25.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:18:0) after 1m0s
[21:23:26.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:18:0)
[21:23:26.143] Timer tick, asking Buildbucket for the build status
[21:23:26.500] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:26.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:19:0) after 1m0s
[21:24:26.527] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:19:0)
[21:24:26.527] Timer tick, asking Buildbucket for the build status
[21:24:28.543] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:28.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:20:0) after 1m0s
[21:25:28.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:20:0)
[21:25:28.620] Timer tick, asking Buildbucket for the build status
[21:25:30.699] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:30.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:21:0) after 1m0s
[21:26:30.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:21:0)
[21:26:30.825] Timer tick, asking Buildbucket for the build status
[21:26:32.098] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:32.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:22:0) after 1m0s
[21:27:32.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:22:0)
[21:27:32.111] Timer tick, asking Buildbucket for the build status
[21:27:32.720] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:32.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:23:0) after 1m0s
[21:28:33.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:23:0)
[21:28:33.120] Timer tick, asking Buildbucket for the build status
[21:28:33.242] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:33.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:24:0) after 1m0s
[21:29:33.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:24:0)
[21:29:33.295] Timer tick, asking Buildbucket for the build status
[21:29:33.450] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:33.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:25:0) after 1m0s
[21:30:33.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:25:0)
[21:30:33.546] Timer tick, asking Buildbucket for the build status
[21:30:33.736] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:33.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:26:0) after 1m0s
[21:31:33.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:26:0)
[21:31:33.762] Timer tick, asking Buildbucket for the build status
[21:31:33.975] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:33.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:27:0) after 1m0s
[21:32:34.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:27:0)
[21:32:34.074] Timer tick, asking Buildbucket for the build status
[21:32:34.260] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:34.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:28:0) after 1m0s
[21:33:34.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:28:0)
[21:33:34.564] Timer tick, asking Buildbucket for the build status
[21:33:35.560] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:29:0) after 1m0s
[21:34:35.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:29:0)
[21:34:35.949] Timer tick, asking Buildbucket for the build status
[21:34:36.141] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:36.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:30:0) after 1m0s
[21:35:36.244] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:30:0)
[21:35:36.244] Timer tick, asking Buildbucket for the build status
[21:35:36.419] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:36.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:31:0) after 1m0s
[21:36:36.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:31:0)
[21:36:36.588] Timer tick, asking Buildbucket for the build status
[21:36:37.386] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:37.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:32:0) after 1m0s
[21:37:37.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:32:0)
[21:37:37.464] Timer tick, asking Buildbucket for the build status
[21:37:37.934] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:37.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:33:0) after 1m0s
[21:38:37.936] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:33:0)
[21:38:37.936] Timer tick, asking Buildbucket for the build status
[21:38:38.105] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:38.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:34:0) after 1m0s
[21:39:38.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:34:0)
[21:39:38.294] Timer tick, asking Buildbucket for the build status
[21:39:38.410] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:38.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:35:0) after 1m0s
[21:40:38.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:35:0)
[21:40:38.439] Timer tick, asking Buildbucket for the build status
[21:40:39.407] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:39.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:36:0) after 1m0s
[21:41:39.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:36:0)
[21:41:39.435] Timer tick, asking Buildbucket for the build status
[21:41:41.664] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:41.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:37:0) after 1m0s
[21:42:41.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:37:0)
[21:42:41.774] Timer tick, asking Buildbucket for the build status
[21:42:41.898] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:41.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:38:0) after 1m0s
[21:43:41.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:38:0)
[21:43:41.943] Timer tick, asking Buildbucket for the build status
[21:43:42.446] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:42.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:39:0) after 1m0s
[21:44:42.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:39:0)
[21:44:42.558] Timer tick, asking Buildbucket for the build status
[21:44:43.631] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:43.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:40:0) after 1m0s
[21:45:43.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:40:0)
[21:45:43.695] Timer tick, asking Buildbucket for the build status
[21:45:43.937] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:43.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:41:0) after 1m0s
[21:46:44.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:41:0)
[21:46:44.032] Timer tick, asking Buildbucket for the build status
[21:46:44.243] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:44.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:42:0) after 1m0s
[21:47:44.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:42:0)
[21:47:44.334] Timer tick, asking Buildbucket for the build status
[21:47:44.511] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:44.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:43:0) after 1m0s
[21:48:44.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:43:0)
[21:48:44.721] Timer tick, asking Buildbucket for the build status
[21:48:45.122] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:45.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:44:0) after 1m0s
[21:49:45.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:44:0)
[21:49:45.342] Timer tick, asking Buildbucket for the build status
[21:49:45.686] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:45.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:45:0) after 1m0s
[21:50:45.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:45:0)
[21:50:45.811] Timer tick, asking Buildbucket for the build status
[21:50:46.073] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:46.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:46:0) after 1m0s
[21:51:46.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:46:0)
[21:51:46.218] Timer tick, asking Buildbucket for the build status
[21:51:47.351] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:47.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:47:0) after 1m0s
[21:52:47.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:47:0)
[21:52:47.581] Timer tick, asking Buildbucket for the build status
[21:52:47.904] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:47.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:48:0) after 1m0s
[21:53:48.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:48:0)
[21:53:48.075] Timer tick, asking Buildbucket for the build status
[21:53:49.619] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:49.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:49:0) after 1m0s
[21:54:49.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:49:0)
[21:54:49.685] Timer tick, asking Buildbucket for the build status
[21:54:51.769] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:51.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:50:0) after 1m0s
[21:55:51.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:50:0)
[21:55:51.794] Timer tick, asking Buildbucket for the build status
[21:55:52.265] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:52.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:51:0) after 1m0s
[21:56:52.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:51:0)
[21:56:52.320] Timer tick, asking Buildbucket for the build status
[21:56:53.163] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:53.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:52:0) after 1m0s
[21:57:53.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:52:0)
[21:57:53.221] Timer tick, asking Buildbucket for the build status
[21:57:53.485] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:53.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:53:0) after 1m0s
[21:58:53.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:53:0)
[21:58:53.525] Timer tick, asking Buildbucket for the build status
[21:58:53.861] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:53.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:54:0) after 1m0s
[21:59:53.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:54:0)
[21:59:53.946] Timer tick, asking Buildbucket for the build status
[21:59:54.633] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:54.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:55:0) after 1m0s
[22:00:54.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:55:0)
[22:00:54.689] Timer tick, asking Buildbucket for the build status
[22:00:55.150] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:55.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:56:0) after 1m0s
[22:01:55.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:56:0)
[22:01:55.193] Timer tick, asking Buildbucket for the build status
[22:01:55.601] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:55.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:57:0) after 1m0s
[22:02:55.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:57:0)
[22:02:55.638] Timer tick, asking Buildbucket for the build status
[22:02:58.558] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:58.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:58:0) after 1m0s
[22:03:58.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:58:0)
[22:03:58.621] Timer tick, asking Buildbucket for the build status
[22:03:59.195] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:59.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:59:0) after 1m0s
[22:04:59.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:59:0)
[22:04:59.352] Timer tick, asking Buildbucket for the build status
[22:04:59.740] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:59.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:60:0) after 1m0s
[22:05:59.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:60:0)
[22:05:59.737] Timer tick, asking Buildbucket for the build status
[22:06:00.245] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:00.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:61:0) after 1m0s
[22:07:00.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:61:0)
[22:07:00.278] Timer tick, asking Buildbucket for the build status
[22:07:00.881] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:00.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:62:0) after 1m0s
[22:08:00.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:62:0)
[22:08:00.910] Timer tick, asking Buildbucket for the build status
[22:08:01.109] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:01.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:63:0) after 1m0s
[22:09:01.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:63:0)
[22:09:01.188] Timer tick, asking Buildbucket for the build status
[22:09:01.716] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:01.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:64:0) after 1m0s
[22:10:01.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:64:0)
[22:10:01.758] Timer tick, asking Buildbucket for the build status
[22:10:04.512] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:04.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:65:0) after 1m0s
[22:11:04.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:65:0)
[22:11:04.820] Timer tick, asking Buildbucket for the build status
[22:11:05.776] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:05.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:66:0) after 1m0s
[22:12:05.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:66:0)
[22:12:05.869] Timer tick, asking Buildbucket for the build status
[22:12:06.083] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:06.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:67:0) after 1m0s
[22:13:06.138] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:67:0)
[22:13:06.138] Timer tick, asking Buildbucket for the build status
[22:13:06.458] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:68:0) after 1m0s
[22:14:06.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:68:0)
[22:14:06.706] Timer tick, asking Buildbucket for the build status
[22:14:07.286] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:07.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:69:0) after 1m0s
[22:15:07.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:69:0)
[22:15:07.337] Timer tick, asking Buildbucket for the build status
[22:15:07.791] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:07.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:70:0) after 1m0s
[22:16:07.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:70:0)
[22:16:07.939] Timer tick, asking Buildbucket for the build status
[22:16:11.946] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:11.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:71:0) after 1m0s
[22:17:12.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:71:0)
[22:17:12.031] Timer tick, asking Buildbucket for the build status
[22:17:13.021] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:13.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:72:0) after 1m0s
[22:18:13.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:72:0)
[22:18:13.161] Timer tick, asking Buildbucket for the build status
[22:18:15.178] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:15.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:73:0) after 1m0s
[22:19:15.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:73:0)
[22:19:15.321] Timer tick, asking Buildbucket for the build status
[22:19:15.568] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:15.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:74:0) after 1m0s
[22:20:15.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:74:0)
[22:20:15.600] Timer tick, asking Buildbucket for the build status
[22:20:16.743] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:16.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:75:0) after 1m0s
[22:21:16.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:75:0)
[22:21:16.795] Timer tick, asking Buildbucket for the build status
[22:21:17.124] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:17.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:76:0) after 1m0s
[22:22:17.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:76:0)
[22:22:17.182] Timer tick, asking Buildbucket for the build status
[22:22:19.559] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:19.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:77:0) after 1m0s
[22:23:19.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:77:0)
[22:23:19.873] Timer tick, asking Buildbucket for the build status
[22:23:20.050] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:20.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:78:0) after 1m0s
[22:24:20.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:78:0)
[22:24:20.131] Timer tick, asking Buildbucket for the build status
[22:24:22.033] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:22.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:79:0) after 1m0s
[22:25:22.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:79:0)
[22:25:22.096] Timer tick, asking Buildbucket for the build status
[22:25:22.411] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:22.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:80:0) after 1m0s
[22:26:22.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:80:0)
[22:26:22.482] Timer tick, asking Buildbucket for the build status
[22:26:23.112] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:23.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:81:0) after 1m0s
[22:27:23.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:81:0)
[22:27:23.172] Timer tick, asking Buildbucket for the build status
[22:27:23.973] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:23.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:82:0) after 1m0s
[22:28:24.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:82:0)
[22:28:24.033] Timer tick, asking Buildbucket for the build status
[22:28:25.681] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:25.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:83:0) after 1m0s
[22:29:25.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:83:0)
[22:29:25.720] Timer tick, asking Buildbucket for the build status
[22:29:26.946] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:26.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:84:0) after 1m0s
[22:30:27.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:84:0)
[22:30:27.060] Timer tick, asking Buildbucket for the build status
[22:30:27.268] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:27.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:85:0) after 1m0s
[22:31:27.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:85:0)
[22:31:27.370] Timer tick, asking Buildbucket for the build status
[22:31:27.569] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:27.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:86:0) after 1m0s
[22:32:27.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:86:0)
[22:32:27.589] Timer tick, asking Buildbucket for the build status
[22:32:28.463] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:28.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:87:0) after 1m0s
[22:33:28.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:87:0)
[22:33:28.508] Timer tick, asking Buildbucket for the build status
[22:33:28.947] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:28.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:88:0) after 1m0s
[22:34:29.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:88:0)
[22:34:29.007] Timer tick, asking Buildbucket for the build status
[22:34:29.953] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:29.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:89:0) after 1m0s
[22:35:30.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:89:0)
[22:35:30.024] Timer tick, asking Buildbucket for the build status
[22:35:30.888] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:30.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:90:0) after 1m0s
[22:36:30.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:90:0)
[22:36:30.950] Timer tick, asking Buildbucket for the build status
[22:36:31.621] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:31.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:91:0) after 1m0s
[22:37:31.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:91:0)
[22:37:31.617] Timer tick, asking Buildbucket for the build status
[22:37:31.870] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:31.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:92:0) after 1m0s
[22:38:31.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:92:0)
[22:38:31.933] Timer tick, asking Buildbucket for the build status
[22:38:32.185] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:32.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:93:0) after 1m0s
[22:39:32.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:93:0)
[22:39:32.311] Timer tick, asking Buildbucket for the build status
[22:39:34.618] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:34.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:94:0) after 1m0s
[22:40:34.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:94:0)
[22:40:34.690] Timer tick, asking Buildbucket for the build status
[22:40:34.948] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:34.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:95:0) after 1m0s
[22:41:34.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:95:0)
[22:41:34.998] Timer tick, asking Buildbucket for the build status
[22:41:37.510] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:37.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:96:0) after 1m0s
[22:42:37.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:96:0)
[22:42:37.538] Timer tick, asking Buildbucket for the build status
[22:42:37.730] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:37.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:97:0) after 1m0s
[22:43:37.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:97:0)
[22:43:37.767] Timer tick, asking Buildbucket for the build status
[22:43:38.512] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:38.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:98:0) after 1m0s
[22:44:38.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:98:0)
[22:44:38.553] Timer tick, asking Buildbucket for the build status
[22:44:39.463] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:39.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:99:0) after 1m0s
[22:45:39.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:99:0)
[22:45:39.483] Timer tick, asking Buildbucket for the build status
[22:45:39.983] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:39.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:100:0) after 1m0s
[22:46:40.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:100:0)
[22:46:40.031] Timer tick, asking Buildbucket for the build status
[22:46:40.637] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:40.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:101:0) after 1m0s
[22:47:40.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:101:0)
[22:47:40.678] Timer tick, asking Buildbucket for the build status
[22:47:40.870] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:40.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:102:0) after 1m0s
[22:48:40.913] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:102:0)
[22:48:40.913] Timer tick, asking Buildbucket for the build status
[22:48:41.109] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:41.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:103:0) after 1m0s
[22:49:41.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:103:0)
[22:49:41.128] Timer tick, asking Buildbucket for the build status
[22:49:41.810] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:41.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:104:0) after 1m0s
[22:50:41.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:104:0)
[22:50:41.869] Timer tick, asking Buildbucket for the build status
[22:50:42.730] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:42.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:105:0) after 1m0s
[22:51:42.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:105:0)
[22:51:42.827] Timer tick, asking Buildbucket for the build status
[22:51:43.086] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:43.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:106:0) after 1m0s
[22:52:43.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:106:0)
[22:52:43.117] Timer tick, asking Buildbucket for the build status
[22:52:43.394] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:43.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:107:0) after 1m0s
[22:53:43.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:107:0)
[22:53:43.465] Timer tick, asking Buildbucket for the build status
[22:53:44.191] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:44.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:108:0) after 1m0s
[22:54:44.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:108:0)
[22:54:44.220] Timer tick, asking Buildbucket for the build status
[22:54:44.816] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:44.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:109:0) after 1m0s
[22:55:44.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:109:0)
[22:55:44.903] Timer tick, asking Buildbucket for the build status
[22:55:45.232] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:45.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:110:0) after 1m0s
[22:56:45.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:110:0)
[22:56:45.264] Timer tick, asking Buildbucket for the build status
[22:56:45.421] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:45.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:111:0) after 1m0s
[22:57:45.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:111:0)
[22:57:45.451] Timer tick, asking Buildbucket for the build status
[22:57:45.757] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:45.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:112:0) after 1m0s
[22:58:45.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:112:0)
[22:58:45.799] Timer tick, asking Buildbucket for the build status
[22:58:46.523] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:46.523] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:113:0) after 1m0s
[22:59:46.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:113:0)
[22:59:46.572] Timer tick, asking Buildbucket for the build status
[22:59:47.152] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:47.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:114:0) after 1m0s
[23:00:47.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:114:0)
[23:00:47.294] Timer tick, asking Buildbucket for the build status
[23:00:47.467] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:47.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:115:0) after 1m0s
[23:01:47.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:115:0)
[23:01:47.508] Timer tick, asking Buildbucket for the build status
[23:01:48.022] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:48.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:116:0) after 1m0s
[23:02:48.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:116:0)
[23:02:48.220] Timer tick, asking Buildbucket for the build status
[23:02:48.456] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:48.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:117:0) after 1m0s
[23:03:48.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:117:0)
[23:03:48.826] Timer tick, asking Buildbucket for the build status
[23:03:50.666] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:50.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:118:0) after 1m0s
[23:04:50.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:118:0)
[23:04:50.876] Timer tick, asking Buildbucket for the build status
[23:04:51.655] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:51.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:119:0) after 1m0s
[23:05:51.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:119:0)
[23:05:51.800] Timer tick, asking Buildbucket for the build status
[23:05:52.387] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:52.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:120:0) after 1m0s
[23:06:52.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:120:0)
[23:06:52.571] Timer tick, asking Buildbucket for the build status
[23:06:53.373] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:53.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:121:0) after 1m0s
[23:07:53.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:121:0)
[23:07:53.463] Timer tick, asking Buildbucket for the build status
[23:07:53.634] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:53.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:122:0) after 1m0s
[23:08:53.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:122:0)
[23:08:53.701] Timer tick, asking Buildbucket for the build status
[23:08:54.765] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:54.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:123:0) after 1m0s
[23:09:54.784] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:123:0)
[23:09:54.784] Timer tick, asking Buildbucket for the build status
[23:09:54.994] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:54.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:124:0) after 1m0s
[23:10:55.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:124:0)
[23:10:55.094] Timer tick, asking Buildbucket for the build status
[23:10:56.210] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:56.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:125:0) after 1m0s
[23:11:56.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:125:0)
[23:11:56.278] Timer tick, asking Buildbucket for the build status
[23:11:57.592] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:57.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:126:0) after 1m0s
[23:12:57.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:126:0)
[23:12:57.616] Timer tick, asking Buildbucket for the build status
[23:12:58.341] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:58.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:127:0) after 1m0s
[23:13:58.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:127:0)
[23:13:58.384] Timer tick, asking Buildbucket for the build status
[23:13:59.885] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:59.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:128:0) after 1m0s
[23:14:59.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:128:0)
[23:14:59.920] Timer tick, asking Buildbucket for the build status
[23:15:00.061] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:00.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:129:0) after 1m0s
[23:16:00.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:129:0)
[23:16:00.113] Timer tick, asking Buildbucket for the build status
[23:16:03.063] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:03.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:130:0) after 1m0s
[23:17:03.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:130:0)
[23:17:03.087] Timer tick, asking Buildbucket for the build status
[23:17:03.615] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:03.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:131:0) after 1m0s
[23:18:03.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:131:0)
[23:18:03.650] Timer tick, asking Buildbucket for the build status
[23:18:04.015] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:04.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:132:0) after 1m0s
[23:19:04.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:132:0)
[23:19:04.136] Timer tick, asking Buildbucket for the build status
[23:19:04.876] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:04.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:133:0) after 1m0s
[23:20:04.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:133:0)
[23:20:04.946] Timer tick, asking Buildbucket for the build status
[23:20:05.130] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:05.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:134:0) after 1m0s
[23:21:05.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:134:0)
[23:21:05.233] Timer tick, asking Buildbucket for the build status
[23:21:05.421] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:05.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:135:0) after 1m0s
[23:22:05.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:135:0)
[23:22:05.523] Timer tick, asking Buildbucket for the build status
[23:22:06.228] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:06.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:136:0) after 1m0s
[23:23:06.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:136:0)
[23:23:06.526] Timer tick, asking Buildbucket for the build status
[23:23:06.976] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:06.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:137:0) after 1m0s
[23:24:07.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:137:0)
[23:24:07.303] Timer tick, asking Buildbucket for the build status
[23:24:07.648] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:07.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:138:0) after 1m0s
[23:25:07.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:138:0)
[23:25:07.693] Timer tick, asking Buildbucket for the build status
[23:25:09.017] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:09.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:139:0) after 1m0s
[23:26:09.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:139:0)
[23:26:09.209] Timer tick, asking Buildbucket for the build status
[23:26:09.458] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:09.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:140:0) after 1m0s
[23:27:09.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:140:0)
[23:27:09.569] Timer tick, asking Buildbucket for the build status
[23:27:10.208] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:10.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:141:0) after 1m0s
[23:28:10.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:141:0)
[23:28:10.233] Timer tick, asking Buildbucket for the build status
[23:28:10.735] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:10.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:142:0) after 1m0s
[23:29:10.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:142:0)
[23:29:10.836] Timer tick, asking Buildbucket for the build status
[23:29:12.096] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:12.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:143:0) after 1m0s
[23:30:12.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:143:0)
[23:30:12.175] Timer tick, asking Buildbucket for the build status
[23:30:12.540] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:12.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:144:0) after 1m0s
[23:31:12.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:144:0)
[23:31:12.640] Timer tick, asking Buildbucket for the build status
[23:31:12.754] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:12.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:145:0) after 1m0s
[23:32:12.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:145:0)
[23:32:12.821] Timer tick, asking Buildbucket for the build status
[23:32:13.052] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:13.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:146:0) after 1m0s
[23:33:13.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:146:0)
[23:33:13.103] Timer tick, asking Buildbucket for the build status
[23:33:13.296] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:13.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:147:0) after 1m0s
[23:34:13.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:147:0)
[23:34:13.327] Timer tick, asking Buildbucket for the build status
[23:34:13.570] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:13.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:148:0) after 1m0s
[23:35:13.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:148:0)
[23:35:13.614] Timer tick, asking Buildbucket for the build status
[23:35:14.254] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:14.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:149:0) after 1m0s
[23:36:14.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:149:0)
[23:36:14.322] Timer tick, asking Buildbucket for the build status
[23:36:15.114] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:15.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:150:0) after 1m0s
[23:37:15.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:150:0)
[23:37:15.241] Timer tick, asking Buildbucket for the build status
[23:37:15.932] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:15.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:151:0) after 1m0s
[23:38:16.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:151:0)
[23:38:16.002] Timer tick, asking Buildbucket for the build status
[23:38:16.474] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:16.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:152:0) after 1m0s
[23:39:16.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:152:0)
[23:39:16.463] Timer tick, asking Buildbucket for the build status
[23:39:16.634] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:16.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:153:0) after 1m0s
[23:40:16.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:153:0)
[23:40:16.695] Timer tick, asking Buildbucket for the build status
[23:40:17.033] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:154:0) after 1m0s
[23:41:17.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:154:0)
[23:41:17.092] Timer tick, asking Buildbucket for the build status
[23:41:17.425] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:17.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:155:0) after 1m0s
[23:42:17.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:155:0)
[23:42:17.460] Timer tick, asking Buildbucket for the build status
[23:42:17.648] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:156:0) after 1m0s
[23:43:17.732] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:156:0)
[23:43:17.732] Timer tick, asking Buildbucket for the build status
[23:43:18.012] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:18.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:157:0) after 1m0s
[23:44:18.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:157:0)
[23:44:18.059] Timer tick, asking Buildbucket for the build status
[23:44:18.377] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:18.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:158:0) after 1m0s
[23:45:18.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:158:0)
[23:45:18.374] Timer tick, asking Buildbucket for the build status
[23:45:21.411] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:21.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:159:0) after 1m0s
[23:46:21.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:159:0)
[23:46:21.437] Timer tick, asking Buildbucket for the build status
[23:46:21.660] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:21.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:160:0) after 1m0s
[23:47:21.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:160:0)
[23:47:21.738] Timer tick, asking Buildbucket for the build status
[23:47:22.769] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:22.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:161:0) after 1m0s
[23:48:22.856] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:161:0)
[23:48:22.856] Timer tick, asking Buildbucket for the build status
[23:48:23.050] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:23.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:162:0) after 1m0s
[23:49:23.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:162:0)
[23:49:23.123] Timer tick, asking Buildbucket for the build status
[23:49:23.612] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:23.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:163:0) after 1m0s
[23:50:23.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:163:0)
[23:50:23.650] Timer tick, asking Buildbucket for the build status
[23:50:23.788] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:23.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:164:0) after 1m0s
[23:51:23.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:164:0)
[23:51:23.850] Timer tick, asking Buildbucket for the build status
[23:51:24.435] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:24.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:165:0) after 1m0s
[23:52:24.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:165:0)
[23:52:24.504] Timer tick, asking Buildbucket for the build status
[23:52:24.679] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:24.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:166:0) after 1m0s
[23:53:24.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:166:0)
[23:53:24.780] Timer tick, asking Buildbucket for the build status
[23:53:24.957] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:24.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:167:0) after 1m0s
[23:54:25.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:167:0)
[23:54:25.032] Timer tick, asking Buildbucket for the build status
[23:54:25.743] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:25.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:168:0) after 1m0s
[23:55:25.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:168:0)
[23:55:25.808] Timer tick, asking Buildbucket for the build status
[23:55:26.136] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:26.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:169:0) after 1m0s
[23:56:26.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:169:0)
[23:56:26.225] Timer tick, asking Buildbucket for the build status
[23:56:26.508] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:26.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:170:0) after 1m0s
[23:57:26.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:170:0)
[23:57:26.666] Timer tick, asking Buildbucket for the build status
[23:57:27.069] Build 8899951741823782272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:27.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9065381805860591264:171:0) after 1m0s
[23:58:14.423] Received PubSub notification, asking Buildbucket for the build status
[23:58:14.570] Build 8899951741823782272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:58:14.570] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1570751893510308",
"created_by": "project:chromium",
"created_ts": "1570741628775477",
"id": "8899951741823782272",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56ef4cb6fce4972f8b94fdfba561b891d92f4d78\"}}",
"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\": 14938, \"got_angle_revision\": \"d200a77a22cf4241ab0e5714f4479ca300334bf1\", \"got_dawn_revision\": \"9e64afcb91f74e75a16fa5639d272c5c2a536bc6\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"56ef4cb6fce4972f8b94fdfba561b891d92f4d78\", \"got_revision_cp\": \"refs/heads/master@{#704825}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_v8_revision\": \"5697a8371da8791c2f8a2a1177d0349b537d4665\", \"got_v8_revision_cp\": \"refs/heads/7.9.272@{#1}\", \"got_webrtc_revision\": \"9e70f3614347983f3c30ef0eeef315889128cbea\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29436}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"56ef4cb6fce4972f8b94fdfba561b891d92f4d78\"}, \"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\": [\"4501-487d554\"], \"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": "1570741677726357",
"status": "COMPLETED",
"status_changed_ts": "1570751893978912",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14938",
"builder:Windows deterministic",
"buildset:commit/git/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/56ef4cb6fce4972f8b94fdfba561b891d92f4d78",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9065381805860591264",
"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/8899951741823782272/+/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:47d05126cd5c7110",
"user_agent:luci-scheduler"
],
"updated_ts": "1570751893985075",
"url": "https://ci.chromium.org/b/8899951741823782272",
"utcnow_ts": "1570751894562745"
}
}
[23:58:14.570] Invocation finished in 2h51m9.02830614s with status SUCCEEDED