[12:34:34.464] New invocation is queued and will start shortly
[12:34:35.664] Starting the invocation (attempt 1)
[12:34:35.698] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:34:35.698] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:34:35.698] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9104823731103538672",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f0b656aa075ce3bcd25869e84a97353ab515e23a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9104823731103538672",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"gitiles_ref:refs/heads/master"
]
}
[12:34:36.953] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1533126875796010",
"id": "8939393669043132544",
"lease_expiration_ts": "1533270876659290",
"lease_key": "700777289",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f0b656aa075ce3bcd25869e84a97353ab515e23a\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1533126876868990",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9622",
"builder:Windows deterministic",
"buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9104823731103538672",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9622",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939393669043132544",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8939393669043132544/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9104823731103538672",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:deb0c5440b41315eb1b2ecc42c3f73946c1d779d",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f0e4d2558b2c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1533126876869120",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9622",
"utcnow_ts": "1533126876941250"
}
}
[12:34:36.953] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9622
[12:34:36.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:2:0) after 1m0s
[12:35:36.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:2:0)
[12:35:36.987] Timer tick, asking Buildbucket for the build status
[12:35:37.061] Build 8939393669043132544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:35:37.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:3:0) after 1m0s
[12:36:37.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:3:0)
[12:36:37.081] Timer tick, asking Buildbucket for the build status
[12:36:37.306] Build 8939393669043132544: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[12:36:37.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:4:0) after 1m0s
[12:36:51.245] Received PubSub notification, asking Buildbucket for the build status
[12:36:51.302] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:4:0)
[12:37:37.327] Timer tick, asking Buildbucket for the build status
[12:37:37.369] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:37.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:6:0) after 1m0s
[12:38:37.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:6:0)
[12:38:37.525] Timer tick, asking Buildbucket for the build status
[12:38:37.606] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:37.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:7:0) after 1m0s
[12:39:37.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:7:0)
[12:39:37.626] Timer tick, asking Buildbucket for the build status
[12:39:37.688] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:37.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:8:0) after 1m0s
[12:40:37.762] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:8:0)
[12:40:37.762] Timer tick, asking Buildbucket for the build status
[12:40:38.081] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:38.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:9:0) after 1m0s
[12:41:38.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:9:0)
[12:41:38.120] Timer tick, asking Buildbucket for the build status
[12:41:38.176] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:38.176] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:10:0) after 1m0s
[12:42:38.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:10:0)
[12:42:38.198] Timer tick, asking Buildbucket for the build status
[12:42:38.285] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:38.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:11:0) after 1m0s
[12:43:38.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:11:0)
[12:43:38.305] Timer tick, asking Buildbucket for the build status
[12:43:38.472] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:38.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:12:0) after 1m0s
[12:44:38.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:12:0)
[12:44:38.524] Timer tick, asking Buildbucket for the build status
[12:44:38.592] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:38.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:13:0) after 1m0s
[12:45:38.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:13:0)
[12:45:38.617] Timer tick, asking Buildbucket for the build status
[12:45:38.750] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:38.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:14:0) after 1m0s
[12:46:38.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:14:0)
[12:46:38.789] Timer tick, asking Buildbucket for the build status
[12:46:38.914] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:38.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:15:0) after 1m0s
[12:47:38.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:15:0)
[12:47:38.937] Timer tick, asking Buildbucket for the build status
[12:47:38.997] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:38.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:16:0) after 1m0s
[12:48:39.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:16:0)
[12:48:39.024] Timer tick, asking Buildbucket for the build status
[12:48:39.061] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:39.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:17:0) after 1m0s
[12:49:39.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:17:0)
[12:49:39.083] Timer tick, asking Buildbucket for the build status
[12:49:39.341] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:39.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:18:0) after 1m0s
[12:50:39.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:18:0)
[12:50:39.360] Timer tick, asking Buildbucket for the build status
[12:50:44.757] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:44.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:19:0) after 1m0s
[12:51:44.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:19:0)
[12:51:44.841] Timer tick, asking Buildbucket for the build status
[12:51:44.922] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:44.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:20:0) after 1m0s
[12:52:44.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:20:0)
[12:52:44.946] Timer tick, asking Buildbucket for the build status
[12:52:44.994] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:44.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:21:0) after 1m0s
[12:53:45.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:21:0)
[12:53:45.042] Timer tick, asking Buildbucket for the build status
[12:53:45.079] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:45.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:22:0) after 1m0s
[12:54:45.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:22:0)
[12:54:45.109] Timer tick, asking Buildbucket for the build status
[12:54:45.147] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:45.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:23:0) after 1m0s
[12:55:45.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:23:0)
[12:55:45.166] Timer tick, asking Buildbucket for the build status
[12:55:45.790] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:45.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:24:0) after 1m0s
[12:56:45.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:24:0)
[12:56:45.815] Timer tick, asking Buildbucket for the build status
[12:56:45.888] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:45.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:25:0) after 1m0s
[12:57:45.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:25:0)
[12:57:45.912] Timer tick, asking Buildbucket for the build status
[12:57:45.992] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:45.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:26:0) after 1m0s
[12:58:46.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:26:0)
[12:58:46.015] Timer tick, asking Buildbucket for the build status
[12:58:46.072] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:46.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:27:0) after 1m0s
[12:59:46.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:27:0)
[12:59:46.098] Timer tick, asking Buildbucket for the build status
[12:59:46.148] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:46.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:28:0) after 1m0s
[13:00:46.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:28:0)
[13:00:46.216] Timer tick, asking Buildbucket for the build status
[13:00:46.350] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:46.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:29:0) after 1m0s
[13:01:46.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:29:0)
[13:01:46.374] Timer tick, asking Buildbucket for the build status
[13:01:46.454] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:46.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:30:0) after 1m0s
[13:02:46.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:30:0)
[13:02:46.477] Timer tick, asking Buildbucket for the build status
[13:02:46.660] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:46.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:31:0) after 1m0s
[13:03:46.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:31:0)
[13:03:46.689] Timer tick, asking Buildbucket for the build status
[13:03:46.758] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:46.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:32:0) after 1m0s
[13:04:46.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:32:0)
[13:04:46.779] Timer tick, asking Buildbucket for the build status
[13:04:46.826] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:46.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:33:0) after 1m0s
[13:05:46.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:33:0)
[13:05:46.850] Timer tick, asking Buildbucket for the build status
[13:05:46.907] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:46.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:34:0) after 1m0s
[13:06:46.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:34:0)
[13:06:46.926] Timer tick, asking Buildbucket for the build status
[13:06:46.959] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:46.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:35:0) after 1m0s
[13:07:46.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:35:0)
[13:07:46.986] Timer tick, asking Buildbucket for the build status
[13:07:47.071] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:47.071] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:36:0) after 1m0s
[13:08:47.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:36:0)
[13:08:47.094] Timer tick, asking Buildbucket for the build status
[13:08:47.149] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:47.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:37:0) after 1m0s
[13:09:47.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:37:0)
[13:09:47.235] Timer tick, asking Buildbucket for the build status
[13:09:47.476] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:47.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:38:0) after 1m0s
[13:10:47.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:38:0)
[13:10:47.517] Timer tick, asking Buildbucket for the build status
[13:10:47.649] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:47.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:39:0) after 1m0s
[13:11:47.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:39:0)
[13:11:47.668] Timer tick, asking Buildbucket for the build status
[13:11:47.705] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:47.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:40:0) after 1m0s
[13:12:47.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:40:0)
[13:12:47.730] Timer tick, asking Buildbucket for the build status
[13:12:47.772] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:47.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:41:0) after 1m0s
[13:13:47.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:41:0)
[13:13:47.801] Timer tick, asking Buildbucket for the build status
[13:13:47.859] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:47.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:42:0) after 1m0s
[13:14:47.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:42:0)
[13:14:47.884] Timer tick, asking Buildbucket for the build status
[13:14:47.926] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:47.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:43:0) after 1m0s
[13:15:47.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:43:0)
[13:15:47.965] Timer tick, asking Buildbucket for the build status
[13:15:48.021] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:48.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:44:0) after 1m0s
[13:16:48.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:44:0)
[13:16:48.128] Timer tick, asking Buildbucket for the build status
[13:16:48.208] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:48.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:45:0) after 1m0s
[13:17:48.254] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:45:0)
[13:17:48.254] Timer tick, asking Buildbucket for the build status
[13:17:48.568] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:48.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:46:0) after 1m0s
[13:18:48.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:46:0)
[13:18:48.591] Timer tick, asking Buildbucket for the build status
[13:18:48.644] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:48.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:47:0) after 1m0s
[13:19:48.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:47:0)
[13:19:48.667] Timer tick, asking Buildbucket for the build status
[13:19:48.722] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:48.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:48:0) after 1m0s
[13:20:48.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:48:0)
[13:20:48.747] Timer tick, asking Buildbucket for the build status
[13:20:48.845] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:48.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:49:0) after 1m0s
[13:21:48.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:49:0)
[13:21:48.874] Timer tick, asking Buildbucket for the build status
[13:21:49.248] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:49.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:50:0) after 1m0s
[13:22:49.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:50:0)
[13:22:49.276] Timer tick, asking Buildbucket for the build status
[13:22:49.375] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:49.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:51:0) after 1m0s
[13:23:49.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:51:0)
[13:23:49.401] Timer tick, asking Buildbucket for the build status
[13:23:49.577] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:49.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:52:0) after 1m0s
[13:24:49.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:52:0)
[13:24:49.706] Timer tick, asking Buildbucket for the build status
[13:24:49.750] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:49.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:53:0) after 1m0s
[13:25:49.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:53:0)
[13:25:49.807] Timer tick, asking Buildbucket for the build status
[13:25:49.908] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:49.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:54:0) after 1m0s
[13:26:49.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:54:0)
[13:26:49.934] Timer tick, asking Buildbucket for the build status
[13:26:49.998] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:49.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:55:0) after 1m0s
[13:27:50.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:55:0)
[13:27:50.036] Timer tick, asking Buildbucket for the build status
[13:27:50.097] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:50.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:56:0) after 1m0s
[13:28:50.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:56:0)
[13:28:50.118] Timer tick, asking Buildbucket for the build status
[13:28:50.276] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:50.276] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:57:0) after 1m0s
[13:29:50.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:57:0)
[13:29:50.301] Timer tick, asking Buildbucket for the build status
[13:29:50.370] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:50.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:58:0) after 1m0s
[13:30:50.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:58:0)
[13:30:50.523] Timer tick, asking Buildbucket for the build status
[13:30:50.605] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:50.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:59:0) after 1m0s
[13:31:50.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:59:0)
[13:31:50.633] Timer tick, asking Buildbucket for the build status
[13:31:50.671] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:50.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:60:0) after 1m0s
[13:32:50.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:60:0)
[13:32:50.690] Timer tick, asking Buildbucket for the build status
[13:32:50.743] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:50.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:61:0) after 1m0s
[13:33:50.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:61:0)
[13:33:50.765] Timer tick, asking Buildbucket for the build status
[13:33:50.816] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:50.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:62:0) after 1m0s
[13:34:50.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:62:0)
[13:34:50.845] Timer tick, asking Buildbucket for the build status
[13:34:51.103] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:51.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:63:0) after 1m0s
[13:35:51.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:63:0)
[13:35:51.136] Timer tick, asking Buildbucket for the build status
[13:35:51.207] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:51.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:64:0) after 1m0s
[13:36:51.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:64:0)
[13:36:51.284] Timer tick, asking Buildbucket for the build status
[13:36:51.341] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:51.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:65:0) after 1m0s
[13:37:51.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:65:0)
[13:37:51.368] Timer tick, asking Buildbucket for the build status
[13:37:51.406] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:51.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:66:0) after 1m0s
[13:38:51.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:66:0)
[13:38:51.428] Timer tick, asking Buildbucket for the build status
[13:38:51.498] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:51.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:67:0) after 1m0s
[13:39:51.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:67:0)
[13:39:51.537] Timer tick, asking Buildbucket for the build status
[13:39:51.586] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:51.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:68:0) after 1m0s
[13:40:51.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:68:0)
[13:40:51.605] Timer tick, asking Buildbucket for the build status
[13:40:51.704] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:51.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:69:0) after 1m0s
[13:41:51.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:69:0)
[13:41:51.839] Timer tick, asking Buildbucket for the build status
[13:41:51.899] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:51.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:70:0) after 1m0s
[13:42:51.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:70:0)
[13:42:51.926] Timer tick, asking Buildbucket for the build status
[13:42:51.965] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:51.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:71:0) after 1m0s
[13:43:51.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:71:0)
[13:43:51.996] Timer tick, asking Buildbucket for the build status
[13:43:52.101] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:52.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:72:0) after 1m0s
[13:44:52.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:72:0)
[13:44:52.224] Timer tick, asking Buildbucket for the build status
[13:44:52.309] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:52.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:73:0) after 1m0s
[13:45:52.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:73:0)
[13:45:52.348] Timer tick, asking Buildbucket for the build status
[13:45:52.397] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:52.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:74:0) after 1m0s
[13:46:52.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:74:0)
[13:46:52.422] Timer tick, asking Buildbucket for the build status
[13:46:52.521] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:52.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:75:0) after 1m0s
[13:47:52.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:75:0)
[13:47:52.546] Timer tick, asking Buildbucket for the build status
[13:47:52.594] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:52.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:76:0) after 1m0s
[13:48:52.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:76:0)
[13:48:52.689] Timer tick, asking Buildbucket for the build status
[13:48:52.736] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:52.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:77:0) after 1m0s
[13:49:52.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:77:0)
[13:49:52.926] Timer tick, asking Buildbucket for the build status
[13:49:52.985] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:52.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:78:0) after 1m0s
[13:50:53.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:78:0)
[13:50:53.009] Timer tick, asking Buildbucket for the build status
[13:50:53.223] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:53.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:79:0) after 1m0s
[13:51:53.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:79:0)
[13:51:53.313] Timer tick, asking Buildbucket for the build status
[13:51:53.352] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:53.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:80:0) after 1m0s
[13:52:53.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:80:0)
[13:52:53.376] Timer tick, asking Buildbucket for the build status
[13:52:53.687] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:53.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:81:0) after 1m0s
[13:53:53.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:81:0)
[13:53:53.710] Timer tick, asking Buildbucket for the build status
[13:53:53.747] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:53.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:82:0) after 1m0s
[13:54:53.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:82:0)
[13:54:53.771] Timer tick, asking Buildbucket for the build status
[13:54:53.809] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:53.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:83:0) after 1m0s
[13:55:53.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:83:0)
[13:55:53.838] Timer tick, asking Buildbucket for the build status
[13:55:53.937] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:53.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:84:0) after 1m0s
[13:56:53.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:84:0)
[13:56:53.960] Timer tick, asking Buildbucket for the build status
[13:56:54.088] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:54.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:85:0) after 1m0s
[13:57:54.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:85:0)
[13:57:54.120] Timer tick, asking Buildbucket for the build status
[13:57:54.158] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:54.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:86:0) after 1m0s
[13:58:54.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:86:0)
[13:58:54.250] Timer tick, asking Buildbucket for the build status
[13:58:54.330] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:54.330] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:87:0) after 1m0s
[13:59:54.352] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:87:0)
[13:59:54.352] Timer tick, asking Buildbucket for the build status
[13:59:54.458] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:54.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:88:0) after 1m0s
[14:00:54.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:88:0)
[14:00:54.483] Timer tick, asking Buildbucket for the build status
[14:00:54.574] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:54.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:89:0) after 1m0s
[14:01:54.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:89:0)
[14:01:54.627] Timer tick, asking Buildbucket for the build status
[14:01:54.670] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:54.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:90:0) after 1m0s
[14:02:54.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:90:0)
[14:02:54.707] Timer tick, asking Buildbucket for the build status
[14:02:54.771] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:54.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:91:0) after 1m0s
[14:03:54.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:91:0)
[14:03:54.795] Timer tick, asking Buildbucket for the build status
[14:03:54.898] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:54.898] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:92:0) after 1m0s
[14:04:54.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:92:0)
[14:04:54.945] Timer tick, asking Buildbucket for the build status
[14:04:55.154] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:55.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:93:0) after 1m0s
[14:05:55.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:93:0)
[14:05:55.188] Timer tick, asking Buildbucket for the build status
[14:05:55.290] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:55.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:94:0) after 1m0s
[14:06:55.314] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:94:0)
[14:06:55.314] Timer tick, asking Buildbucket for the build status
[14:06:55.405] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:55.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:95:0) after 1m0s
[14:07:55.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:95:0)
[14:07:55.429] Timer tick, asking Buildbucket for the build status
[14:07:55.483] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:55.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:96:0) after 1m0s
[14:08:55.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:96:0)
[14:08:55.516] Timer tick, asking Buildbucket for the build status
[14:08:55.610] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:55.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:97:0) after 1m0s
[14:09:55.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:97:0)
[14:09:55.635] Timer tick, asking Buildbucket for the build status
[14:09:55.745] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:55.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:98:0) after 1m0s
[14:10:55.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:98:0)
[14:10:55.769] Timer tick, asking Buildbucket for the build status
[14:10:55.842] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:55.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:99:0) after 1m0s
[14:11:55.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:99:0)
[14:11:55.866] Timer tick, asking Buildbucket for the build status
[14:11:55.949] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:55.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:100:0) after 1m0s
[14:12:56.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:100:0)
[14:12:56.025] Timer tick, asking Buildbucket for the build status
[14:12:56.122] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:56.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:101:0) after 1m0s
[14:13:56.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:101:0)
[14:13:56.147] Timer tick, asking Buildbucket for the build status
[14:13:56.216] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:56.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:102:0) after 1m0s
[14:14:56.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:102:0)
[14:14:56.240] Timer tick, asking Buildbucket for the build status
[14:14:56.321] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:56.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:103:0) after 1m0s
[14:15:56.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:103:0)
[14:15:56.356] Timer tick, asking Buildbucket for the build status
[14:15:56.394] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:56.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:104:0) after 1m0s
[14:16:56.418] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:104:0)
[14:16:56.418] Timer tick, asking Buildbucket for the build status
[14:16:57.050] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:57.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:105:0) after 1m0s
[14:17:57.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:105:0)
[14:17:57.189] Timer tick, asking Buildbucket for the build status
[14:17:57.226] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:57.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:106:0) after 1m0s
[14:18:57.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:106:0)
[14:18:57.282] Timer tick, asking Buildbucket for the build status
[14:18:57.346] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:57.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:107:0) after 1m0s
[14:19:57.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:107:0)
[14:19:57.425] Timer tick, asking Buildbucket for the build status
[14:19:57.489] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:57.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:108:0) after 1m0s
[14:20:57.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:108:0)
[14:20:57.515] Timer tick, asking Buildbucket for the build status
[14:20:57.653] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:57.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:109:0) after 1m0s
[14:21:57.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:109:0)
[14:21:57.679] Timer tick, asking Buildbucket for the build status
[14:21:57.752] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:57.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:110:0) after 1m0s
[14:22:57.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:110:0)
[14:22:57.888] Timer tick, asking Buildbucket for the build status
[14:22:57.930] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:57.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:111:0) after 1m0s
[14:23:57.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:111:0)
[14:23:57.957] Timer tick, asking Buildbucket for the build status
[14:23:58.094] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:58.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:112:0) after 1m0s
[14:24:58.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:112:0)
[14:24:58.135] Timer tick, asking Buildbucket for the build status
[14:24:58.222] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:58.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:113:0) after 1m0s
[14:25:58.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:113:0)
[14:25:58.267] Timer tick, asking Buildbucket for the build status
[14:25:58.323] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:58.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:114:0) after 1m0s
[14:26:58.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:114:0)
[14:26:58.357] Timer tick, asking Buildbucket for the build status
[14:26:58.435] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:58.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:115:0) after 1m0s
[14:27:58.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:115:0)
[14:27:58.461] Timer tick, asking Buildbucket for the build status
[14:27:58.526] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:58.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:116:0) after 1m0s
[14:28:58.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:116:0)
[14:28:58.552] Timer tick, asking Buildbucket for the build status
[14:28:58.611] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:58.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:117:0) after 1m0s
[14:29:58.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:117:0)
[14:29:58.656] Timer tick, asking Buildbucket for the build status
[14:29:58.736] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:58.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:118:0) after 1m0s
[14:30:58.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:118:0)
[14:30:58.766] Timer tick, asking Buildbucket for the build status
[14:30:58.843] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:58.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:119:0) after 1m0s
[14:31:58.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:119:0)
[14:31:58.926] Timer tick, asking Buildbucket for the build status
[14:31:58.955] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:58.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:120:0) after 1m0s
[14:32:58.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:120:0)
[14:32:58.983] Timer tick, asking Buildbucket for the build status
[14:32:59.054] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:59.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:121:0) after 1m0s
[14:33:59.080] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:121:0)
[14:33:59.080] Timer tick, asking Buildbucket for the build status
[14:33:59.163] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:59.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:122:0) after 1m0s
[14:34:59.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:122:0)
[14:34:59.189] Timer tick, asking Buildbucket for the build status
[14:34:59.543] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:59.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:123:0) after 1m0s
[14:35:59.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:123:0)
[14:35:59.570] Timer tick, asking Buildbucket for the build status
[14:35:59.854] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:59.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:124:0) after 1m0s
[14:36:59.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:124:0)
[14:36:59.889] Timer tick, asking Buildbucket for the build status
[14:37:00.028] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:00.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:125:0) after 1m0s
[14:38:00.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:125:0)
[14:38:00.057] Timer tick, asking Buildbucket for the build status
[14:38:00.237] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:00.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:126:0) after 1m0s
[14:39:00.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:126:0)
[14:39:00.281] Timer tick, asking Buildbucket for the build status
[14:39:00.434] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:00.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:127:0) after 1m0s
[14:40:00.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:127:0)
[14:40:00.464] Timer tick, asking Buildbucket for the build status
[14:40:00.564] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:00.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:128:0) after 1m0s
[14:41:00.591] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:128:0)
[14:41:00.591] Timer tick, asking Buildbucket for the build status
[14:41:00.793] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:00.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:129:0) after 1m0s
[14:42:00.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:129:0)
[14:42:00.901] Timer tick, asking Buildbucket for the build status
[14:42:00.966] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:00.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:130:0) after 1m0s
[14:43:00.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:130:0)
[14:43:00.993] Timer tick, asking Buildbucket for the build status
[14:43:01.166] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:01.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:131:0) after 1m0s
[14:44:01.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:131:0)
[14:44:01.207] Timer tick, asking Buildbucket for the build status
[14:44:01.376] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:01.376] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:132:0) after 1m0s
[14:45:01.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:132:0)
[14:45:01.437] Timer tick, asking Buildbucket for the build status
[14:45:01.500] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:01.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:133:0) after 1m0s
[14:46:01.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:133:0)
[14:46:01.538] Timer tick, asking Buildbucket for the build status
[14:46:01.688] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:01.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:134:0) after 1m0s
[14:47:01.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:134:0)
[14:47:01.717] Timer tick, asking Buildbucket for the build status
[14:47:01.814] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:01.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:135:0) after 1m0s
[14:48:01.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:135:0)
[14:48:01.840] Timer tick, asking Buildbucket for the build status
[14:48:01.900] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:01.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:136:0) after 1m0s
[14:49:01.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:136:0)
[14:49:01.930] Timer tick, asking Buildbucket for the build status
[14:49:02.248] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:02.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:137:0) after 1m0s
[14:50:02.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:137:0)
[14:50:02.278] Timer tick, asking Buildbucket for the build status
[14:50:02.384] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:02.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:138:0) after 1m0s
[14:51:02.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:138:0)
[14:51:02.534] Timer tick, asking Buildbucket for the build status
[14:51:02.621] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:02.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:139:0) after 1m0s
[14:52:02.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:139:0)
[14:52:02.666] Timer tick, asking Buildbucket for the build status
[14:52:02.722] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:02.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:140:0) after 1m0s
[14:53:02.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:140:0)
[14:53:02.758] Timer tick, asking Buildbucket for the build status
[14:53:02.877] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:02.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:141:0) after 1m0s
[14:54:02.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:141:0)
[14:54:02.972] Timer tick, asking Buildbucket for the build status
[14:54:03.086] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:03.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:142:0) after 1m0s
[14:55:03.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:142:0)
[14:55:03.123] Timer tick, asking Buildbucket for the build status
[14:55:03.243] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:03.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:143:0) after 1m0s
[14:56:03.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:143:0)
[14:56:03.304] Timer tick, asking Buildbucket for the build status
[14:56:03.341] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:03.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:144:0) after 1m0s
[14:57:03.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:144:0)
[14:57:03.370] Timer tick, asking Buildbucket for the build status
[14:57:03.650] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:03.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:145:0) after 1m0s
[14:58:03.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:145:0)
[14:58:03.690] Timer tick, asking Buildbucket for the build status
[14:58:03.907] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:03.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:146:0) after 1m0s
[14:59:03.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:146:0)
[14:59:03.948] Timer tick, asking Buildbucket for the build status
[14:59:09.484] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:09.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:147:0) after 1m0s
[15:00:09.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:147:0)
[15:00:09.513] Timer tick, asking Buildbucket for the build status
[15:00:09.578] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:09.578] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:148:0) after 1m0s
[15:01:09.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:148:0)
[15:01:09.620] Timer tick, asking Buildbucket for the build status
[15:01:09.666] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:09.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:149:0) after 1m0s
[15:02:09.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:149:0)
[15:02:09.692] Timer tick, asking Buildbucket for the build status
[15:02:09.782] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:09.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:150:0) after 1m0s
[15:03:09.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:150:0)
[15:03:09.812] Timer tick, asking Buildbucket for the build status
[15:03:09.891] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:09.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:151:0) after 1m0s
[15:04:09.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:151:0)
[15:04:09.918] Timer tick, asking Buildbucket for the build status
[15:04:10.023] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:10.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:152:0) after 1m0s
[15:05:10.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:152:0)
[15:05:10.053] Timer tick, asking Buildbucket for the build status
[15:05:10.189] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:10.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:153:0) after 1m0s
[15:06:10.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:153:0)
[15:06:10.222] Timer tick, asking Buildbucket for the build status
[15:06:10.305] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:10.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:154:0) after 1m0s
[15:07:10.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:154:0)
[15:07:10.344] Timer tick, asking Buildbucket for the build status
[15:07:10.423] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:10.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:155:0) after 1m0s
[15:08:10.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:155:0)
[15:08:10.464] Timer tick, asking Buildbucket for the build status
[15:08:10.503] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:10.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:156:0) after 1m0s
[15:09:10.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:156:0)
[15:09:10.528] Timer tick, asking Buildbucket for the build status
[15:09:10.597] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:10.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:157:0) after 1m0s
[15:10:10.649] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:157:0)
[15:10:10.649] Timer tick, asking Buildbucket for the build status
[15:10:10.723] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:10.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:158:0) after 1m0s
[15:11:10.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:158:0)
[15:11:10.751] Timer tick, asking Buildbucket for the build status
[15:11:10.868] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:10.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:159:0) after 1m0s
[15:12:10.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:159:0)
[15:12:10.895] Timer tick, asking Buildbucket for the build status
[15:12:10.992] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:10.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:160:0) after 1m0s
[15:13:11.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:160:0)
[15:13:11.114] Timer tick, asking Buildbucket for the build status
[15:13:11.243] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:11.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:161:0) after 1m0s
[15:14:11.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:161:0)
[15:14:11.270] Timer tick, asking Buildbucket for the build status
[15:14:11.425] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:11.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:162:0) after 1m0s
[15:15:11.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:162:0)
[15:15:11.450] Timer tick, asking Buildbucket for the build status
[15:15:11.580] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:11.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:163:0) after 1m0s
[15:16:11.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:163:0)
[15:16:11.616] Timer tick, asking Buildbucket for the build status
[15:16:11.658] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:11.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:164:0) after 1m0s
[15:17:11.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:164:0)
[15:17:11.928] Timer tick, asking Buildbucket for the build status
[15:17:11.998] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:11.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:165:0) after 1m0s
[15:18:12.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:165:0)
[15:18:12.220] Timer tick, asking Buildbucket for the build status
[15:18:12.279] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:12.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:166:0) after 1m0s
[15:19:12.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:166:0)
[15:19:12.316] Timer tick, asking Buildbucket for the build status
[15:19:12.359] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:12.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:167:0) after 1m0s
[15:20:12.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:167:0)
[15:20:12.390] Timer tick, asking Buildbucket for the build status
[15:20:12.495] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:12.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:168:0) after 1m0s
[15:21:12.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:168:0)
[15:21:12.537] Timer tick, asking Buildbucket for the build status
[15:21:12.623] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:12.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:169:0) after 1m0s
[15:22:12.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:169:0)
[15:22:12.665] Timer tick, asking Buildbucket for the build status
[15:22:12.720] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:12.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:170:0) after 1m0s
[15:23:12.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:170:0)
[15:23:12.745] Timer tick, asking Buildbucket for the build status
[15:23:12.837] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:12.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:171:0) after 1m0s
[15:24:12.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:171:0)
[15:24:12.865] Timer tick, asking Buildbucket for the build status
[15:24:12.965] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:12.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:172:0) after 1m0s
[15:25:12.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:172:0)
[15:25:12.999] Timer tick, asking Buildbucket for the build status
[15:25:13.039] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:13.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:173:0) after 1m0s
[15:26:13.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:173:0)
[15:26:13.079] Timer tick, asking Buildbucket for the build status
[15:26:13.141] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:13.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:174:0) after 1m0s
[15:27:13.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:174:0)
[15:27:13.184] Timer tick, asking Buildbucket for the build status
[15:27:13.246] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:13.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:175:0) after 1m0s
[15:28:13.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:175:0)
[15:28:13.273] Timer tick, asking Buildbucket for the build status
[15:28:13.431] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:13.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:176:0) after 1m0s
[15:29:13.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:176:0)
[15:29:13.466] Timer tick, asking Buildbucket for the build status
[15:29:13.662] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:13.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:177:0) after 1m0s
[15:30:13.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:177:0)
[15:30:13.722] Timer tick, asking Buildbucket for the build status
[15:30:13.782] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:13.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:178:0) after 1m0s
[15:31:13.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:178:0)
[15:31:13.811] Timer tick, asking Buildbucket for the build status
[15:31:13.850] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:13.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:179:0) after 1m0s
[15:32:13.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:179:0)
[15:32:13.939] Timer tick, asking Buildbucket for the build status
[15:32:14.079] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:14.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:180:0) after 1m0s
[15:33:14.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:180:0)
[15:33:14.110] Timer tick, asking Buildbucket for the build status
[15:33:14.181] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:14.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:181:0) after 1m0s
[15:34:14.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:181:0)
[15:34:14.222] Timer tick, asking Buildbucket for the build status
[15:34:14.388] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:14.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:182:0) after 1m0s
[15:35:14.429] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:182:0)
[15:35:14.429] Timer tick, asking Buildbucket for the build status
[15:35:14.467] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:14.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:183:0) after 1m0s
[15:36:14.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:183:0)
[15:36:14.494] Timer tick, asking Buildbucket for the build status
[15:36:14.537] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:14.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:184:0) after 1m0s
[15:37:14.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:184:0)
[15:37:14.573] Timer tick, asking Buildbucket for the build status
[15:37:14.857] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:14.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:185:0) after 1m0s
[15:38:14.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:185:0)
[15:38:14.885] Timer tick, asking Buildbucket for the build status
[15:38:14.925] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:14.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:186:0) after 1m0s
[15:39:15.026] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:186:0)
[15:39:15.026] Timer tick, asking Buildbucket for the build status
[15:39:15.075] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:15.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:187:0) after 1m0s
[15:40:15.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:187:0)
[15:40:15.105] Timer tick, asking Buildbucket for the build status
[15:40:15.374] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:15.374] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:188:0) after 1m0s
[15:41:15.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:188:0)
[15:41:15.400] Timer tick, asking Buildbucket for the build status
[15:41:15.453] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:15.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:189:0) after 1m0s
[15:42:15.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:189:0)
[15:42:15.508] Timer tick, asking Buildbucket for the build status
[15:42:15.544] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:15.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:190:0) after 1m0s
[15:43:15.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:190:0)
[15:43:15.653] Timer tick, asking Buildbucket for the build status
[15:43:15.715] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:15.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:191:0) after 1m0s
[15:44:15.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:191:0)
[15:44:15.749] Timer tick, asking Buildbucket for the build status
[15:44:15.868] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:15.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:192:0) after 1m0s
[15:45:15.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:192:0)
[15:45:15.897] Timer tick, asking Buildbucket for the build status
[15:45:15.995] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:15.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:193:0) after 1m0s
[15:46:16.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:193:0)
[15:46:16.024] Timer tick, asking Buildbucket for the build status
[15:46:16.134] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:16.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:194:0) after 1m0s
[15:47:16.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:194:0)
[15:47:16.162] Timer tick, asking Buildbucket for the build status
[15:47:16.218] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:16.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:195:0) after 1m0s
[15:48:16.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:195:0)
[15:48:16.309] Timer tick, asking Buildbucket for the build status
[15:48:16.394] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:16.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:196:0) after 1m0s
[15:49:16.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:196:0)
[15:49:16.449] Timer tick, asking Buildbucket for the build status
[15:49:16.532] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:16.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:197:0) after 1m0s
[15:50:16.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:197:0)
[15:50:16.652] Timer tick, asking Buildbucket for the build status
[15:50:16.693] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:16.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:198:0) after 1m0s
[15:51:16.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:198:0)
[15:51:16.721] Timer tick, asking Buildbucket for the build status
[15:51:16.787] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:16.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:199:0) after 1m0s
[15:52:16.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:199:0)
[15:52:16.821] Timer tick, asking Buildbucket for the build status
[15:52:16.873] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:16.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:200:0) after 1m0s
[15:53:16.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:200:0)
[15:53:16.954] Timer tick, asking Buildbucket for the build status
[15:53:17.012] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:17.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:201:0) after 1m0s
[15:54:17.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:201:0)
[15:54:17.042] Timer tick, asking Buildbucket for the build status
[15:54:17.091] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:17.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:202:0) after 1m0s
[15:55:17.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:202:0)
[15:55:17.121] Timer tick, asking Buildbucket for the build status
[15:55:17.180] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:17.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:203:0) after 1m0s
[15:56:17.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:203:0)
[15:56:17.224] Timer tick, asking Buildbucket for the build status
[15:56:17.296] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:17.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:204:0) after 1m0s
[15:57:17.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:204:0)
[15:57:17.331] Timer tick, asking Buildbucket for the build status
[15:57:17.378] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:17.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:205:0) after 1m0s
[15:58:17.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:205:0)
[15:58:17.405] Timer tick, asking Buildbucket for the build status
[15:58:17.704] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:17.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:206:0) after 1m0s
[15:59:17.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:206:0)
[15:59:17.745] Timer tick, asking Buildbucket for the build status
[15:59:17.828] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:17.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:207:0) after 1m0s
[16:00:17.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:207:0)
[16:00:17.864] Timer tick, asking Buildbucket for the build status
[16:00:17.945] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:17.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:208:0) after 1m0s
[16:01:18.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:208:0)
[16:01:18.093] Timer tick, asking Buildbucket for the build status
[16:01:18.230] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:18.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:209:0) after 1m0s
[16:02:18.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:209:0)
[16:02:18.261] Timer tick, asking Buildbucket for the build status
[16:02:18.394] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:18.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:210:0) after 1m0s
[16:03:18.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:210:0)
[16:03:18.532] Timer tick, asking Buildbucket for the build status
[16:03:18.653] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:18.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:211:0) after 1m0s
[16:04:18.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:211:0)
[16:04:18.680] Timer tick, asking Buildbucket for the build status
[16:04:18.713] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:18.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:212:0) after 1m0s
[16:05:18.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:212:0)
[16:05:18.758] Timer tick, asking Buildbucket for the build status
[16:05:18.836] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:18.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:213:0) after 1m0s
[16:06:18.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:213:0)
[16:06:18.867] Timer tick, asking Buildbucket for the build status
[16:06:19.010] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:19.010] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:214:0) after 1m0s
[16:07:19.041] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:214:0)
[16:07:19.041] Timer tick, asking Buildbucket for the build status
[16:07:19.102] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:19.102] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:215:0) after 1m0s
[16:08:19.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:215:0)
[16:08:19.136] Timer tick, asking Buildbucket for the build status
[16:08:19.170] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:19.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:216:0) after 1m0s
[16:09:19.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:216:0)
[16:09:19.202] Timer tick, asking Buildbucket for the build status
[16:09:19.245] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:19.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:217:0) after 1m0s
[16:10:19.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:217:0)
[16:10:19.281] Timer tick, asking Buildbucket for the build status
[16:10:19.418] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:19.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:218:0) after 1m0s
[16:11:19.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:218:0)
[16:11:19.452] Timer tick, asking Buildbucket for the build status
[16:11:19.509] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:19.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:219:0) after 1m0s
[16:12:19.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:219:0)
[16:12:19.540] Timer tick, asking Buildbucket for the build status
[16:12:19.599] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:19.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:220:0) after 1m0s
[16:13:19.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:220:0)
[16:13:19.628] Timer tick, asking Buildbucket for the build status
[16:13:19.741] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:19.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:221:0) after 1m0s
[16:14:19.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:221:0)
[16:14:19.777] Timer tick, asking Buildbucket for the build status
[16:14:19.866] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:19.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:222:0) after 1m0s
[16:15:19.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:222:0)
[16:15:19.892] Timer tick, asking Buildbucket for the build status
[16:15:19.949] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:19.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:223:0) after 1m0s
[16:16:19.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:223:0)
[16:16:19.979] Timer tick, asking Buildbucket for the build status
[16:16:20.193] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:20.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:224:0) after 1m0s
[16:17:20.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:224:0)
[16:17:20.331] Timer tick, asking Buildbucket for the build status
[16:17:20.436] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:20.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:225:0) after 1m0s
[16:18:20.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:225:0)
[16:18:20.481] Timer tick, asking Buildbucket for the build status
[16:18:20.550] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:20.550] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:226:0) after 1m0s
[16:19:20.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:226:0)
[16:19:20.583] Timer tick, asking Buildbucket for the build status
[16:19:20.674] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:20.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:227:0) after 1m0s
[16:20:20.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:227:0)
[16:20:20.709] Timer tick, asking Buildbucket for the build status
[16:20:20.749] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:20.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:228:0) after 1m0s
[16:21:20.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:228:0)
[16:21:20.782] Timer tick, asking Buildbucket for the build status
[16:21:20.843] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:20.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:229:0) after 1m0s
[16:22:20.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:229:0)
[16:22:20.892] Timer tick, asking Buildbucket for the build status
[16:22:20.938] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:20.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:230:0) after 1m0s
[16:23:20.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:230:0)
[16:23:20.969] Timer tick, asking Buildbucket for the build status
[16:23:21.248] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:21.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:231:0) after 1m0s
[16:24:21.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:231:0)
[16:24:21.283] Timer tick, asking Buildbucket for the build status
[16:24:21.329] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:21.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:232:0) after 1m0s
[16:25:21.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:232:0)
[16:25:21.358] Timer tick, asking Buildbucket for the build status
[16:25:21.613] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:21.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:233:0) after 1m0s
[16:26:21.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:233:0)
[16:26:21.646] Timer tick, asking Buildbucket for the build status
[16:26:21.900] Build 8939393669043132544: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:21.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104823731103538672:234:0) after 1m0s
[16:27:10.461] Received PubSub notification, asking Buildbucket for the build status
[16:27:10.498] Build 8939393669043132544: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[16:27:10.498] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1533140828971510",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1533126875796010",
"failure_reason": "BUILD_FAILURE",
"id": "8939393669043132544",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f0b656aa075ce3bcd25869e84a97353ab515e23a\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"compare_build_artifacts\"}, \"humanReason\": \"Step('compare_build_artifacts') failed with return_code 1\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8939393669043132544/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3704-de2166f\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"fa95e2a7489d9efe3f8dd770c204b4d968eb9b02\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"f0b656aa075ce3bcd25869e84a97353ab515e23a\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24158}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#579777}\", \"branch\": \"refs/heads/master\", \"revision\": \"f0b656aa075ce3bcd25869e84a97353ab515e23a\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"6e250820b17ef1833da52948426a55ae075c6094\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"ad63728be30db3c76f35e2ed20793cad19d8b422\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1533126875796010, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9104823731103538672\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8939393669043132544\"}}, \"got_v8_revision\": \"c1e3354d56b2da398aa06a2429a09e7b878fe8eb\", \"got_v8_revision_cp\": \"refs/heads/7.0.116@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9622, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"9a90d9aaadeb5e04327ed05775f45132e4b3523f\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1533127010178810",
"status": "COMPLETED",
"status_changed_ts": "1533140829896830",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9622",
"builder:Windows deterministic",
"buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9104823731103538672",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9622",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939393669043132544",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f0b656aa075ce3bcd25869e84a97353ab515e23a",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8939393669043132544/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9104823731103538672",
"swarming_tag:scheduler_job_id:chromium/Windows deterministic",
"swarming_tag:service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:deb0c5440b41315eb1b2ecc42c3f73946c1d779d",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f0e4d2558b2c710",
"user_agent:luci-scheduler"
],
"updated_ts": "1533140829898690",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9622",
"utcnow_ts": "1533140830486500"
}
}
[16:27:10.498] Invocation finished in 3h52m36.050536835s with status FAILED