[02:48:22.498] New invocation is queued and will start shortly
[02:48:23.896] Starting the invocation (attempt 1)
[02:48:23.942] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:48:23.942] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:48:23.942] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9073604658194819920",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"66c30654b88b6b0b8e1f92e35f41b98294251c1f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9073604658194819920",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"gitiles_ref:refs/heads/master"
]
}
[02:48:25.809] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1562899704406125",
"id": "8908174595511120080",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"66c30654b88b6b0b8e1f92e35f41b98294251c1f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1562899705481250",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14102",
"builder:Windows deterministic",
"buildset:commit/git/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073604658194819920",
"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/8908174595511120080/+/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": "1562899705481340",
"url": "https://ci.chromium.org/b/8908174595511120080",
"utcnow_ts": "1562899705779952"
}
}
[02:48:25.809] Task URL: https://ci.chromium.org/b/8908174595511120080
[02:48:25.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:2:0) after 1m0s
[02:49:25.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:2:0)
[02:49:25.875] Timer tick, asking Buildbucket for the build status
[02:49:26.012] Build 8908174595511120080: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:49:26.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:3:0) after 1m0s
[02:49:28.387] Received PubSub notification, asking Buildbucket for the build status
[02:49:29.216] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:26.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:3:0)
[02:50:26.016] Timer tick, asking Buildbucket for the build status
[02:50:26.195] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:5:0) after 1m0s
[02:51:26.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:5:0)
[02:51:26.285] Timer tick, asking Buildbucket for the build status
[02:51:26.516] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:26.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:6:0) after 1m0s
[02:52:26.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:6:0)
[02:52:26.556] Timer tick, asking Buildbucket for the build status
[02:52:27.330] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:27.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:7:0) after 1m0s
[02:53:27.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:7:0)
[02:53:27.455] Timer tick, asking Buildbucket for the build status
[02:53:27.767] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:27.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:8:0) after 1m0s
[02:54:27.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:8:0)
[02:54:27.764] Timer tick, asking Buildbucket for the build status
[02:54:27.926] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:27.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:9:0) after 1m0s
[02:55:27.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:9:0)
[02:55:27.954] Timer tick, asking Buildbucket for the build status
[02:55:28.709] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:28.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:10:0) after 1m0s
[02:56:28.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:10:0)
[02:56:28.753] Timer tick, asking Buildbucket for the build status
[02:56:32.579] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:32.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:11:0) after 1m0s
[02:57:32.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:11:0)
[02:57:32.607] Timer tick, asking Buildbucket for the build status
[02:57:32.822] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:32.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:12:0) after 1m0s
[02:58:32.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:12:0)
[02:58:32.841] Timer tick, asking Buildbucket for the build status
[02:58:33.022] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:13:0) after 1m0s
[02:59:33.637] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:13:0)
[02:59:33.637] Timer tick, asking Buildbucket for the build status
[02:59:33.893] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:33.893] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:14:0) after 1m0s
[03:00:34.050] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:14:0)
[03:00:34.050] Timer tick, asking Buildbucket for the build status
[03:00:34.198] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:34.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:15:0) after 1m0s
[03:01:34.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:15:0)
[03:01:34.861] Timer tick, asking Buildbucket for the build status
[03:01:35.442] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:35.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:16:0) after 1m0s
[03:02:35.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:16:0)
[03:02:35.657] Timer tick, asking Buildbucket for the build status
[03:02:36.063] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:36.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:17:0) after 1m0s
[03:03:36.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:17:0)
[03:03:36.327] Timer tick, asking Buildbucket for the build status
[03:03:36.531] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:36.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:18:0) after 1m0s
[03:04:36.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:18:0)
[03:04:36.741] Timer tick, asking Buildbucket for the build status
[03:04:37.304] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:37.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:19:0) after 1m0s
[03:05:37.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:19:0)
[03:05:37.581] Timer tick, asking Buildbucket for the build status
[03:05:38.337] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:38.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:20:0) after 1m0s
[03:06:38.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:20:0)
[03:06:38.408] Timer tick, asking Buildbucket for the build status
[03:06:40.858] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:40.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:21:0) after 1m0s
[03:07:41.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:21:0)
[03:07:41.230] Timer tick, asking Buildbucket for the build status
[03:07:41.428] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:41.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:22:0) after 1m0s
[03:08:41.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:22:0)
[03:08:41.729] Timer tick, asking Buildbucket for the build status
[03:08:44.546] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:44.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:23:0) after 1m0s
[03:09:44.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:23:0)
[03:09:44.578] Timer tick, asking Buildbucket for the build status
[03:09:45.159] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:24:0) after 1m0s
[03:10:45.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:24:0)
[03:10:45.236] Timer tick, asking Buildbucket for the build status
[03:10:46.025] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:46.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:25:0) after 1m0s
[03:11:46.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:25:0)
[03:11:46.344] Timer tick, asking Buildbucket for the build status
[03:11:46.597] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:46.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:26:0) after 1m0s
[03:12:46.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:26:0)
[03:12:46.786] Timer tick, asking Buildbucket for the build status
[03:12:47.103] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:47.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:27:0) after 1m0s
[03:13:47.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:27:0)
[03:13:47.246] Timer tick, asking Buildbucket for the build status
[03:13:47.639] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:47.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:28:0) after 1m0s
[03:14:47.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:28:0)
[03:14:47.715] Timer tick, asking Buildbucket for the build status
[03:14:47.928] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:47.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:29:0) after 1m0s
[03:15:48.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:29:0)
[03:15:48.112] Timer tick, asking Buildbucket for the build status
[03:15:48.389] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:48.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:30:0) after 1m0s
[03:16:48.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:30:0)
[03:16:48.532] Timer tick, asking Buildbucket for the build status
[03:16:49.004] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:49.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:31:0) after 1m0s
[03:17:49.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:31:0)
[03:17:49.415] Timer tick, asking Buildbucket for the build status
[03:17:50.541] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:50.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:32:0) after 1m0s
[03:18:50.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:32:0)
[03:18:50.753] Timer tick, asking Buildbucket for the build status
[03:18:50.945] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:50.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:33:0) after 1m0s
[03:19:51.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:33:0)
[03:19:51.264] Timer tick, asking Buildbucket for the build status
[03:19:51.952] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:34:0) after 1m0s
[03:20:52.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:34:0)
[03:20:52.246] Timer tick, asking Buildbucket for the build status
[03:20:52.474] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:52.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:35:0) after 1m0s
[03:21:52.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:35:0)
[03:21:52.541] Timer tick, asking Buildbucket for the build status
[03:21:52.801] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:52.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:36:0) after 1m0s
[03:22:52.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:36:0)
[03:22:52.860] Timer tick, asking Buildbucket for the build status
[03:22:54.350] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:54.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:37:0) after 1m0s
[03:23:54.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:37:0)
[03:23:54.399] Timer tick, asking Buildbucket for the build status
[03:23:55.258] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:55.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:38:0) after 1m0s
[03:24:55.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:38:0)
[03:24:55.285] Timer tick, asking Buildbucket for the build status
[03:24:55.439] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:55.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:39:0) after 1m0s
[03:25:55.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:39:0)
[03:25:55.473] Timer tick, asking Buildbucket for the build status
[03:25:56.172] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:56.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:40:0) after 1m0s
[03:26:56.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:40:0)
[03:26:56.197] Timer tick, asking Buildbucket for the build status
[03:26:56.328] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:56.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:41:0) after 1m0s
[03:27:56.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:41:0)
[03:27:56.433] Timer tick, asking Buildbucket for the build status
[03:27:56.735] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:56.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:42:0) after 1m0s
[03:28:56.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:42:0)
[03:28:56.767] Timer tick, asking Buildbucket for the build status
[03:28:57.215] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:57.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:43:0) after 1m0s
[03:29:57.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:43:0)
[03:29:57.249] Timer tick, asking Buildbucket for the build status
[03:29:57.430] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:57.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:44:0) after 1m0s
[03:30:57.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:44:0)
[03:30:57.654] Timer tick, asking Buildbucket for the build status
[03:30:57.808] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:57.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:45:0) after 1m0s
[03:32:14.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:45:0)
[03:32:14.046] Timer tick, asking Buildbucket for the build status
[03:32:14.195] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:14.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:46:0) after 1m0s
[03:42:14.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:46:0)
[03:42:14.576] Timer tick, asking Buildbucket for the build status
[03:42:14.743] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:14.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:47:0) after 1m0s
[03:43:14.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:47:0)
[03:43:14.874] Timer tick, asking Buildbucket for the build status
[03:43:15.011] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:15.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:48:0) after 1m0s
[03:44:15.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:48:0)
[03:44:15.038] Timer tick, asking Buildbucket for the build status
[03:44:15.404] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:15.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:49:0) after 1m0s
[03:45:15.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:49:0)
[03:45:15.450] Timer tick, asking Buildbucket for the build status
[03:45:15.599] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:15.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:50:0) after 1m0s
[03:46:15.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:50:0)
[03:46:15.653] Timer tick, asking Buildbucket for the build status
[03:46:16.990] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:16.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:51:0) after 1m0s
[03:47:17.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:51:0)
[03:47:17.020] Timer tick, asking Buildbucket for the build status
[03:47:17.527] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:17.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:52:0) after 1m0s
[03:48:17.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:52:0)
[03:48:17.506] Timer tick, asking Buildbucket for the build status
[03:48:18.850] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:18.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:53:0) after 1m0s
[03:49:18.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:53:0)
[03:49:18.878] Timer tick, asking Buildbucket for the build status
[03:49:18.978] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:18.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:54:0) after 1m0s
[03:50:19.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:54:0)
[03:50:19.002] Timer tick, asking Buildbucket for the build status
[03:50:19.662] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:19.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:55:0) after 1m0s
[03:51:19.723] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:55:0)
[03:51:19.723] Timer tick, asking Buildbucket for the build status
[03:51:19.837] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:19.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:56:0) after 1m0s
[03:52:19.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:56:0)
[03:52:19.824] Timer tick, asking Buildbucket for the build status
[03:52:21.727] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:21.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:57:0) after 1m0s
[03:53:21.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:57:0)
[03:53:21.746] Timer tick, asking Buildbucket for the build status
[03:53:22.368] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:22.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:58:0) after 1m0s
[03:54:22.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:58:0)
[03:54:22.401] Timer tick, asking Buildbucket for the build status
[03:54:22.595] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:22.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:59:0) after 1m0s
[03:55:22.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:59:0)
[03:55:22.630] Timer tick, asking Buildbucket for the build status
[03:55:23.159] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:23.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:60:0) after 1m0s
[03:56:23.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:60:0)
[03:56:23.159] Timer tick, asking Buildbucket for the build status
[03:56:23.780] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:23.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:61:0) after 1m0s
[03:57:23.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:61:0)
[03:57:23.824] Timer tick, asking Buildbucket for the build status
[03:57:26.349] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:26.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:62:0) after 1m0s
[03:58:26.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:62:0)
[03:58:26.367] Timer tick, asking Buildbucket for the build status
[03:58:27.735] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:27.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:63:0) after 1m0s
[03:59:27.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:63:0)
[03:59:27.728] Timer tick, asking Buildbucket for the build status
[03:59:27.962] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:27.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:64:0) after 1m0s
[04:00:28.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:64:0)
[04:00:28.051] Timer tick, asking Buildbucket for the build status
[04:00:30.433] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:30.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:65:0) after 1m0s
[04:01:30.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:65:0)
[04:01:30.533] Timer tick, asking Buildbucket for the build status
[04:01:30.696] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:30.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:66:0) after 1m0s
[04:02:30.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:66:0)
[04:02:30.737] Timer tick, asking Buildbucket for the build status
[04:02:30.996] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:30.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:67:0) after 1m0s
[04:03:31.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:67:0)
[04:03:31.037] Timer tick, asking Buildbucket for the build status
[04:03:31.223] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:31.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:68:0) after 1m0s
[04:04:31.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:68:0)
[04:04:31.251] Timer tick, asking Buildbucket for the build status
[04:04:31.406] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:31.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:69:0) after 1m0s
[04:05:31.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:69:0)
[04:05:31.479] Timer tick, asking Buildbucket for the build status
[04:05:32.792] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:32.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:70:0) after 1m0s
[04:06:32.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:70:0)
[04:06:32.835] Timer tick, asking Buildbucket for the build status
[04:06:33.166] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:33.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:71:0) after 1m0s
[04:07:33.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:71:0)
[04:07:33.192] Timer tick, asking Buildbucket for the build status
[04:07:35.379] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:35.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:72:0) after 1m0s
[04:08:35.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:72:0)
[04:08:35.405] Timer tick, asking Buildbucket for the build status
[04:08:35.560] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:35.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:73:0) after 1m0s
[04:09:35.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:73:0)
[04:09:35.593] Timer tick, asking Buildbucket for the build status
[04:09:35.733] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:35.733] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:74:0) after 1m0s
[04:10:35.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:74:0)
[04:10:35.764] Timer tick, asking Buildbucket for the build status
[04:10:36.267] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:36.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:75:0) after 1m0s
[04:11:36.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:75:0)
[04:11:36.336] Timer tick, asking Buildbucket for the build status
[04:11:36.556] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:36.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:76:0) after 1m0s
[04:12:36.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:76:0)
[04:12:36.617] Timer tick, asking Buildbucket for the build status
[04:12:37.190] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:37.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:77:0) after 1m0s
[04:13:37.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:77:0)
[04:13:37.234] Timer tick, asking Buildbucket for the build status
[04:13:37.968] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:37.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:78:0) after 1m0s
[04:14:38.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:78:0)
[04:14:38.018] Timer tick, asking Buildbucket for the build status
[04:14:38.997] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:38.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:79:0) after 1m0s
[04:15:39.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:79:0)
[04:15:39.131] Timer tick, asking Buildbucket for the build status
[04:15:39.299] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:39.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:80:0) after 1m0s
[04:16:39.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:80:0)
[04:16:39.415] Timer tick, asking Buildbucket for the build status
[04:16:42.217] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:42.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:81:0) after 1m0s
[04:17:42.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:81:0)
[04:17:42.322] Timer tick, asking Buildbucket for the build status
[04:17:43.651] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:43.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:82:0) after 1m0s
[04:18:43.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:82:0)
[04:18:43.674] Timer tick, asking Buildbucket for the build status
[04:18:44.051] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:44.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:83:0) after 1m0s
[04:19:44.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:83:0)
[04:19:44.060] Timer tick, asking Buildbucket for the build status
[04:19:44.320] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:44.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:84:0) after 1m0s
[04:20:44.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:84:0)
[04:20:44.323] Timer tick, asking Buildbucket for the build status
[04:20:44.612] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:44.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:85:0) after 1m0s
[04:21:44.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:85:0)
[04:21:44.649] Timer tick, asking Buildbucket for the build status
[04:21:44.822] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:44.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:86:0) after 1m0s
[04:22:44.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:86:0)
[04:22:44.883] Timer tick, asking Buildbucket for the build status
[04:22:45.072] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:45.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:87:0) after 1m0s
[04:23:45.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:87:0)
[04:23:45.105] Timer tick, asking Buildbucket for the build status
[04:23:47.451] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:88:0) after 1m0s
[04:24:47.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:88:0)
[04:24:47.494] Timer tick, asking Buildbucket for the build status
[04:24:47.855] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:89:0) after 1m0s
[04:25:47.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:89:0)
[04:25:47.985] Timer tick, asking Buildbucket for the build status
[04:25:48.238] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:48.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:90:0) after 1m0s
[04:26:48.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:90:0)
[04:26:48.295] Timer tick, asking Buildbucket for the build status
[04:26:50.799] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:50.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:91:0) after 1m0s
[04:27:50.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:91:0)
[04:27:50.897] Timer tick, asking Buildbucket for the build status
[04:27:51.219] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:51.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:92:0) after 1m0s
[04:28:51.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:92:0)
[04:28:51.388] Timer tick, asking Buildbucket for the build status
[04:28:51.703] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:51.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:93:0) after 1m0s
[04:29:51.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:93:0)
[04:29:51.782] Timer tick, asking Buildbucket for the build status
[04:29:52.354] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:52.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:94:0) after 1m0s
[04:30:52.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:94:0)
[04:30:52.389] Timer tick, asking Buildbucket for the build status
[04:30:52.618] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:52.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:95:0) after 1m0s
[04:31:52.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:95:0)
[04:31:52.636] Timer tick, asking Buildbucket for the build status
[04:31:52.747] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:52.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:96:0) after 1m0s
[04:32:52.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:96:0)
[04:32:52.742] Timer tick, asking Buildbucket for the build status
[04:32:53.324] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:53.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:97:0) after 1m0s
[04:33:53.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:97:0)
[04:33:53.380] Timer tick, asking Buildbucket for the build status
[04:33:53.771] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:53.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:98:0) after 1m0s
[04:34:53.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:98:0)
[04:34:53.809] Timer tick, asking Buildbucket for the build status
[04:34:54.025] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:54.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:99:0) after 1m0s
[04:35:54.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:99:0)
[04:35:54.063] Timer tick, asking Buildbucket for the build status
[04:35:54.323] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:54.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:100:0) after 1m0s
[04:36:54.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:100:0)
[04:36:54.422] Timer tick, asking Buildbucket for the build status
[04:36:54.549] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:54.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:101:0) after 1m0s
[04:37:54.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:101:0)
[04:37:54.617] Timer tick, asking Buildbucket for the build status
[04:37:54.743] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:54.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:102:0) after 1m0s
[04:38:54.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:102:0)
[04:38:54.773] Timer tick, asking Buildbucket for the build status
[04:38:55.022] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:55.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:103:0) after 1m0s
[04:39:55.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:103:0)
[04:39:55.034] Timer tick, asking Buildbucket for the build status
[04:39:56.145] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:56.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:104:0) after 1m0s
[04:40:56.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:104:0)
[04:40:56.227] Timer tick, asking Buildbucket for the build status
[04:40:56.412] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:56.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:105:0) after 1m0s
[04:41:56.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:105:0)
[04:41:56.441] Timer tick, asking Buildbucket for the build status
[04:41:57.539] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:57.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:106:0) after 1m0s
[04:42:57.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:106:0)
[04:42:57.568] Timer tick, asking Buildbucket for the build status
[04:42:57.998] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:57.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:107:0) after 1m0s
[04:43:58.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:107:0)
[04:43:58.032] Timer tick, asking Buildbucket for the build status
[04:43:58.182] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:58.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:108:0) after 1m0s
[04:44:58.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:108:0)
[04:44:58.213] Timer tick, asking Buildbucket for the build status
[04:44:58.496] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:58.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:109:0) after 1m0s
[04:45:58.521] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:109:0)
[04:45:58.521] Timer tick, asking Buildbucket for the build status
[04:45:58.633] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:58.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:110:0) after 1m0s
[04:46:58.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:110:0)
[04:46:58.667] Timer tick, asking Buildbucket for the build status
[04:47:00.777] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:00.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:111:0) after 1m0s
[04:48:00.849] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:111:0)
[04:48:00.849] Timer tick, asking Buildbucket for the build status
[04:48:01.313] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:01.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:112:0) after 1m0s
[04:49:01.342] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:112:0)
[04:49:01.342] Timer tick, asking Buildbucket for the build status
[04:49:01.500] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:01.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:113:0) after 1m0s
[04:50:01.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:113:0)
[04:50:01.524] Timer tick, asking Buildbucket for the build status
[04:50:02.494] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:02.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:114:0) after 1m0s
[04:51:02.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:114:0)
[04:51:02.547] Timer tick, asking Buildbucket for the build status
[04:51:05.694] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:05.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:115:0) after 1m0s
[04:52:05.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:115:0)
[04:52:05.820] Timer tick, asking Buildbucket for the build status
[04:52:05.946] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:05.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:116:0) after 1m0s
[04:53:06.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:116:0)
[04:53:06.039] Timer tick, asking Buildbucket for the build status
[04:53:06.239] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:06.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:117:0) after 1m0s
[04:54:06.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:117:0)
[04:54:06.337] Timer tick, asking Buildbucket for the build status
[04:54:08.907] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:08.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:118:0) after 1m0s
[04:55:08.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:118:0)
[04:55:08.892] Timer tick, asking Buildbucket for the build status
[04:55:09.951] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:09.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:119:0) after 1m0s
[04:56:10.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:119:0)
[04:56:10.159] Timer tick, asking Buildbucket for the build status
[04:56:10.477] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:10.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:120:0) after 1m0s
[04:57:10.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:120:0)
[04:57:10.624] Timer tick, asking Buildbucket for the build status
[04:57:10.746] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:10.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:121:0) after 1m0s
[04:58:10.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:121:0)
[04:58:10.966] Timer tick, asking Buildbucket for the build status
[04:58:12.885] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:12.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:122:0) after 1m0s
[04:59:12.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:122:0)
[04:59:12.986] Timer tick, asking Buildbucket for the build status
[04:59:13.206] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:13.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:123:0) after 1m0s
[05:00:13.259] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:123:0)
[05:00:13.259] Timer tick, asking Buildbucket for the build status
[05:00:13.746] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:13.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:124:0) after 1m0s
[05:01:13.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:124:0)
[05:01:13.842] Timer tick, asking Buildbucket for the build status
[05:01:15.142] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:125:0) after 1m0s
[05:02:15.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:125:0)
[05:02:15.283] Timer tick, asking Buildbucket for the build status
[05:02:15.931] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:15.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:126:0) after 1m0s
[05:03:16.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:126:0)
[05:03:16.018] Timer tick, asking Buildbucket for the build status
[05:03:17.678] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:17.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:127:0) after 1m0s
[05:04:17.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:127:0)
[05:04:17.805] Timer tick, asking Buildbucket for the build status
[05:04:18.408] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:18.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:128:0) after 1m0s
[05:05:18.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:128:0)
[05:05:18.557] Timer tick, asking Buildbucket for the build status
[05:05:18.698] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:18.698] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:129:0) after 1m0s
[05:06:18.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:129:0)
[05:06:18.727] Timer tick, asking Buildbucket for the build status
[05:06:20.726] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:20.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:130:0) after 1m0s
[05:07:20.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:130:0)
[05:07:20.879] Timer tick, asking Buildbucket for the build status
[05:07:21.268] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:21.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:131:0) after 1m0s
[05:08:21.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:131:0)
[05:08:21.407] Timer tick, asking Buildbucket for the build status
[05:08:28.969] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:28.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:132:0) after 1m0s
[05:09:29.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:132:0)
[05:09:29.076] Timer tick, asking Buildbucket for the build status
[05:09:29.491] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:29.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:133:0) after 1m0s
[05:10:29.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:133:0)
[05:10:29.583] Timer tick, asking Buildbucket for the build status
[05:10:29.873] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:29.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:134:0) after 1m0s
[05:11:29.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:134:0)
[05:11:29.976] Timer tick, asking Buildbucket for the build status
[05:11:30.187] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:30.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:135:0) after 1m0s
[05:12:30.215] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:135:0)
[05:12:30.215] Timer tick, asking Buildbucket for the build status
[05:12:30.673] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:30.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:136:0) after 1m0s
[05:13:30.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:136:0)
[05:13:30.760] Timer tick, asking Buildbucket for the build status
[05:13:33.200] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:33.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:137:0) after 1m0s
[05:14:33.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:137:0)
[05:14:33.267] Timer tick, asking Buildbucket for the build status
[05:14:33.484] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:33.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:138:0) after 1m0s
[05:15:33.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:138:0)
[05:15:33.562] Timer tick, asking Buildbucket for the build status
[05:15:34.452] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:34.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:139:0) after 1m0s
[05:16:34.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:139:0)
[05:16:34.488] Timer tick, asking Buildbucket for the build status
[05:16:34.954] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:34.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:140:0) after 1m0s
[05:17:35.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:140:0)
[05:17:35.159] Timer tick, asking Buildbucket for the build status
[05:17:35.880] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:35.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:141:0) after 1m0s
[05:18:36.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:141:0)
[05:18:36.116] Timer tick, asking Buildbucket for the build status
[05:18:38.009] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:38.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:142:0) after 1m0s
[05:19:38.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:142:0)
[05:19:38.106] Timer tick, asking Buildbucket for the build status
[05:19:38.467] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:38.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:143:0) after 1m0s
[05:20:38.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:143:0)
[05:20:38.514] Timer tick, asking Buildbucket for the build status
[05:20:40.957] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:40.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:144:0) after 1m0s
[05:21:41.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:144:0)
[05:21:41.035] Timer tick, asking Buildbucket for the build status
[05:21:41.554] Build 8908174595511120080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:41.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:145:0) after 1m0s
[05:22:41.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9073604658194819920:145:0)
[05:22:41.646] Timer tick, asking Buildbucket for the build status
[05:22:41.988] Build 8908174595511120080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:22:41.988] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1562908940975347",
"created_by": "project:chromium",
"created_ts": "1562899704406125",
"id": "8908174595511120080",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"66c30654b88b6b0b8e1f92e35f41b98294251c1f\"}}",
"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-xbv6\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14102, \"got_angle_revision\": \"ecd2e3b15215d8812c05d18a60704642cc1103cf\", \"got_dawn_revision\": \"27e67b5f97191ed448ae5b11885c42845dd4cebc\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"66c30654b88b6b0b8e1f92e35f41b98294251c1f\", \"got_revision_cp\": \"refs/heads/master@{#676717}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"2206e55ad023327a744c06084a594944486d0ef8\", \"got_v8_revision_cp\": \"refs/heads/7.7.216@{#1}\", \"got_webrtc_revision\": \"0f0668e328995a62f2b7749150a67a6efa373d2e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28544}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"66c30654b88b6b0b8e1f92e35f41b98294251c1f\"}, \"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-xbv6\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4370-0e704a3\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1562899731816063",
"status": "COMPLETED",
"status_changed_ts": "1562908961406350",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14102",
"builder:Windows deterministic",
"buildset:commit/git/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/66c30654b88b6b0b8e1f92e35f41b98294251c1f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9073604658194819920",
"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/8908174595511120080/+/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:45fce67a78060210",
"user_agent:luci-scheduler"
],
"updated_ts": "1562908961446359",
"url": "https://ci.chromium.org/b/8908174595511120080",
"utcnow_ts": "1562908961972175"
}
}
[05:22:41.988] Invocation finished in 2h34m19.525359068s with status SUCCEEDED