[01:54:28.171] New invocation is queued and will start shortly
[01:54:29.443] Starting the invocation (attempt 1)
[01:54:29.507] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:54:29.508] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:54:29.508] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9108940866508484288",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"f30471c585171ddd4240258f35b9f31300da7e0b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9108940866508484288",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b",
"gitiles_ref:refs/heads/master"
]
}
[01:54:31.587] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1529200469589110",
"experimental": true,
"id": "8943510804358879296",
"lease_expiration_ts": "1529236470418966",
"lease_key": "742331769",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f30471c585171ddd4240258f35b9f31300da7e0b\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1529200471490710",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/50",
"builder:Windows deterministic",
"buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9108940866508484288",
"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/50",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943510804358879296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b",
"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/8943510804358879296/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"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:9108940866508484288",
"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:7b1b5d239a2e04e83d3627884ca58c970e37b2b0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e2444effd1fa810",
"user_agent:luci-scheduler"
],
"updated_ts": "1529200471490819",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/50",
"utcnow_ts": "1529200471568805"
}
}
[01:54:31.587] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/50
[01:54:31.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:2:0) after 1m0s
[01:55:31.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:2:0)
[01:55:31.603] Timer tick, asking Buildbucket for the build status
[01:55:31.737] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:31.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:3:0) after 1m0s
[01:56:31.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:3:0)
[01:56:31.756] Timer tick, asking Buildbucket for the build status
[01:56:31.981] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:31.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:4:0) after 1m0s
[01:57:31.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:4:0)
[01:57:31.999] Timer tick, asking Buildbucket for the build status
[01:57:32.063] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:32.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:5:0) after 1m0s
[01:58:32.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:5:0)
[01:58:32.081] Timer tick, asking Buildbucket for the build status
[01:58:32.138] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:32.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:6:0) after 1m0s
[01:59:32.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:6:0)
[01:59:32.158] Timer tick, asking Buildbucket for the build status
[01:59:32.217] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:32.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:7:0) after 1m0s
[02:00:32.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:7:0)
[02:00:32.255] Timer tick, asking Buildbucket for the build status
[02:00:32.360] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:32.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:8:0) after 1m0s
[02:01:32.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:8:0)
[02:01:32.420] Timer tick, asking Buildbucket for the build status
[02:01:32.564] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:32.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:9:0) after 1m0s
[02:02:32.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:9:0)
[02:02:32.589] Timer tick, asking Buildbucket for the build status
[02:02:32.874] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:32.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:10:0) after 1m0s
[02:03:32.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:10:0)
[02:03:32.892] Timer tick, asking Buildbucket for the build status
[02:03:32.963] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:32.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:11:0) after 1m0s
[02:04:32.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:11:0)
[02:04:32.981] Timer tick, asking Buildbucket for the build status
[02:04:33.020] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:33.020] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:12:0) after 1m0s
[02:05:33.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:12:0)
[02:05:33.038] Timer tick, asking Buildbucket for the build status
[02:05:33.099] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:33.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:13:0) after 1m0s
[02:06:33.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:13:0)
[02:06:33.127] Timer tick, asking Buildbucket for the build status
[02:06:33.269] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:33.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:14:0) after 1m0s
[02:07:33.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:14:0)
[02:07:33.302] Timer tick, asking Buildbucket for the build status
[02:07:33.358] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:33.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:15:0) after 1m0s
[02:08:33.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:15:0)
[02:08:33.395] Timer tick, asking Buildbucket for the build status
[02:08:33.591] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:33.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:16:0) after 1m0s
[02:09:33.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:16:0)
[02:09:33.616] Timer tick, asking Buildbucket for the build status
[02:09:33.674] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:33.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:17:0) after 1m0s
[02:10:33.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:17:0)
[02:10:33.691] Timer tick, asking Buildbucket for the build status
[02:10:33.789] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:33.789] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:18:0) after 1m0s
[02:11:33.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:18:0)
[02:11:33.807] Timer tick, asking Buildbucket for the build status
[02:11:33.868] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:33.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:19:0) after 1m0s
[02:12:33.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:19:0)
[02:12:33.942] Timer tick, asking Buildbucket for the build status
[02:12:34.014] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:34.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:20:0) after 1m0s
[02:13:34.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:20:0)
[02:13:34.238] Timer tick, asking Buildbucket for the build status
[02:13:34.319] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:34.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:21:0) after 1m0s
[02:14:34.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:21:0)
[02:14:34.336] Timer tick, asking Buildbucket for the build status
[02:14:34.391] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:34.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:22:0) after 1m0s
[02:15:34.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:22:0)
[02:15:34.409] Timer tick, asking Buildbucket for the build status
[02:15:34.529] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:34.529] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:23:0) after 1m0s
[02:16:34.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:23:0)
[02:16:34.548] Timer tick, asking Buildbucket for the build status
[02:16:34.601] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:34.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:24:0) after 1m0s
[02:17:34.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:24:0)
[02:17:34.622] Timer tick, asking Buildbucket for the build status
[02:17:34.745] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:34.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:25:0) after 1m0s
[02:18:34.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:25:0)
[02:18:34.767] Timer tick, asking Buildbucket for the build status
[02:18:34.826] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:34.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:26:0) after 1m0s
[02:19:12.034] Received PubSub notification, asking Buildbucket for the build status
[02:19:12.079] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:34.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:26:0)
[02:19:34.846] Timer tick, asking Buildbucket for the build status
[02:19:34.892] Build 8943510804358879296: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:34.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:28:0) after 1m0s
[02:20:02.557] Received PubSub notification, asking Buildbucket for the build status
[02:20:02.589] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:34.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:28:0)
[02:20:34.922] Timer tick, asking Buildbucket for the build status
[02:20:34.957] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:30:0) after 1m0s
[02:21:34.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:30:0)
[02:21:34.976] Timer tick, asking Buildbucket for the build status
[02:21:35.082] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:35.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:31:0) after 1m0s
[02:22:35.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:31:0)
[02:22:35.105] Timer tick, asking Buildbucket for the build status
[02:22:35.165] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:35.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:32:0) after 1m0s
[02:23:35.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:32:0)
[02:23:35.184] Timer tick, asking Buildbucket for the build status
[02:23:35.246] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:35.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:33:0) after 1m0s
[02:24:35.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:33:0)
[02:24:35.316] Timer tick, asking Buildbucket for the build status
[02:24:35.369] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:35.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:34:0) after 1m0s
[02:25:35.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:34:0)
[02:25:35.449] Timer tick, asking Buildbucket for the build status
[02:25:35.503] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:35.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:35:0) after 1m0s
[02:26:35.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:35:0)
[02:26:35.566] Timer tick, asking Buildbucket for the build status
[02:26:35.669] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:35.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:36:0) after 1m0s
[02:27:35.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:36:0)
[02:27:35.692] Timer tick, asking Buildbucket for the build status
[02:27:35.864] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:35.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:37:0) after 1m0s
[02:28:35.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:37:0)
[02:28:35.889] Timer tick, asking Buildbucket for the build status
[02:28:35.949] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:35.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:38:0) after 1m0s
[02:29:35.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:38:0)
[02:29:35.970] Timer tick, asking Buildbucket for the build status
[02:29:36.007] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:36.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:39:0) after 1m0s
[02:30:36.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:39:0)
[02:30:36.070] Timer tick, asking Buildbucket for the build status
[02:30:36.144] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:36.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:40:0) after 1m0s
[02:31:36.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:40:0)
[02:31:36.180] Timer tick, asking Buildbucket for the build status
[02:31:36.272] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:36.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:41:0) after 1m0s
[02:32:36.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:41:0)
[02:32:36.303] Timer tick, asking Buildbucket for the build status
[02:32:36.361] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:36.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:42:0) after 1m0s
[02:33:36.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:42:0)
[02:33:36.397] Timer tick, asking Buildbucket for the build status
[02:33:36.469] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:36.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:43:0) after 1m0s
[02:34:36.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:43:0)
[02:34:36.501] Timer tick, asking Buildbucket for the build status
[02:34:36.568] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:36.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:44:0) after 1m0s
[02:35:36.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:44:0)
[02:35:36.587] Timer tick, asking Buildbucket for the build status
[02:35:36.638] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:36.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:45:0) after 1m0s
[02:36:36.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:45:0)
[02:36:36.662] Timer tick, asking Buildbucket for the build status
[02:36:36.796] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:36.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:46:0) after 1m0s
[02:37:36.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:46:0)
[02:37:36.816] Timer tick, asking Buildbucket for the build status
[02:37:36.915] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:36.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:47:0) after 1m0s
[02:38:36.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:47:0)
[02:38:36.952] Timer tick, asking Buildbucket for the build status
[02:38:37.106] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:37.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:48:0) after 1m0s
[02:39:37.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:48:0)
[02:39:37.132] Timer tick, asking Buildbucket for the build status
[02:39:37.173] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:37.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:49:0) after 1m0s
[02:40:37.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:49:0)
[02:40:37.227] Timer tick, asking Buildbucket for the build status
[02:40:37.275] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:37.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:50:0) after 1m0s
[02:41:37.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:50:0)
[02:41:37.300] Timer tick, asking Buildbucket for the build status
[02:41:37.357] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:37.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:51:0) after 1m0s
[02:42:37.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:51:0)
[02:42:37.375] Timer tick, asking Buildbucket for the build status
[02:42:37.435] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:37.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:52:0) after 1m0s
[02:43:37.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:52:0)
[02:43:37.457] Timer tick, asking Buildbucket for the build status
[02:43:37.519] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:37.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:53:0) after 1m0s
[02:44:37.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:53:0)
[02:44:37.548] Timer tick, asking Buildbucket for the build status
[02:44:37.582] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:37.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:54:0) after 1m0s
[02:45:37.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:54:0)
[02:45:37.604] Timer tick, asking Buildbucket for the build status
[02:45:37.699] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:37.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:55:0) after 1m0s
[02:46:37.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:55:0)
[02:46:37.727] Timer tick, asking Buildbucket for the build status
[02:46:37.776] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:37.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:56:0) after 1m0s
[02:47:37.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:56:0)
[02:47:37.845] Timer tick, asking Buildbucket for the build status
[02:47:37.907] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:37.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:57:0) after 1m0s
[02:48:38.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:57:0)
[02:48:38.045] Timer tick, asking Buildbucket for the build status
[02:48:38.351] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:38.351] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:58:0) after 1m0s
[02:49:38.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:58:0)
[02:49:38.371] Timer tick, asking Buildbucket for the build status
[02:49:38.399] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:38.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:59:0) after 1m0s
[02:50:38.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:59:0)
[02:50:38.421] Timer tick, asking Buildbucket for the build status
[02:50:38.554] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:38.554] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:60:0) after 1m0s
[02:51:38.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:60:0)
[02:51:38.581] Timer tick, asking Buildbucket for the build status
[02:51:38.641] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:38.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:61:0) after 1m0s
[02:52:38.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:61:0)
[02:52:38.668] Timer tick, asking Buildbucket for the build status
[02:52:38.719] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:38.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:62:0) after 1m0s
[02:53:38.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:62:0)
[02:53:38.737] Timer tick, asking Buildbucket for the build status
[02:53:38.788] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:38.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:63:0) after 1m0s
[02:54:38.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:63:0)
[02:54:38.806] Timer tick, asking Buildbucket for the build status
[02:54:38.868] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:38.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:64:0) after 1m0s
[02:55:38.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:64:0)
[02:55:38.945] Timer tick, asking Buildbucket for the build status
[02:55:39.066] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:39.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:65:0) after 1m0s
[02:56:39.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:65:0)
[02:56:39.084] Timer tick, asking Buildbucket for the build status
[02:56:39.148] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:39.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:66:0) after 1m0s
[02:57:39.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:66:0)
[02:57:39.166] Timer tick, asking Buildbucket for the build status
[02:57:39.226] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:39.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:67:0) after 1m0s
[02:58:39.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:67:0)
[02:58:39.336] Timer tick, asking Buildbucket for the build status
[02:58:39.511] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:39.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:68:0) after 1m0s
[02:59:39.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:68:0)
[02:59:39.552] Timer tick, asking Buildbucket for the build status
[02:59:39.680] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:39.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:69:0) after 1m0s
[03:00:39.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:69:0)
[03:00:39.740] Timer tick, asking Buildbucket for the build status
[03:00:39.798] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:39.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:70:0) after 1m0s
[03:01:39.933] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:70:0)
[03:01:39.933] Timer tick, asking Buildbucket for the build status
[03:01:40.006] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:40.006] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:71:0) after 1m0s
[03:02:40.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:71:0)
[03:02:40.123] Timer tick, asking Buildbucket for the build status
[03:02:40.200] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:40.201] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:72:0) after 1m0s
[03:03:40.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:72:0)
[03:03:40.315] Timer tick, asking Buildbucket for the build status
[03:03:40.397] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:40.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:73:0) after 1m0s
[03:04:40.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:73:0)
[03:04:40.551] Timer tick, asking Buildbucket for the build status
[03:04:40.607] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:40.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:74:0) after 1m0s
[03:05:40.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:74:0)
[03:05:40.765] Timer tick, asking Buildbucket for the build status
[03:05:40.950] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:40.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:75:0) after 1m0s
[03:06:40.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:75:0)
[03:06:40.976] Timer tick, asking Buildbucket for the build status
[03:06:41.075] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:41.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:76:0) after 1m0s
[03:07:41.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:76:0)
[03:07:41.151] Timer tick, asking Buildbucket for the build status
[03:07:41.294] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:41.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:77:0) after 1m0s
[03:08:41.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:77:0)
[03:08:41.363] Timer tick, asking Buildbucket for the build status
[03:08:41.421] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:41.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:78:0) after 1m0s
[03:09:41.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:78:0)
[03:09:41.456] Timer tick, asking Buildbucket for the build status
[03:09:41.575] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:41.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:79:0) after 1m0s
[03:10:41.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:79:0)
[03:10:41.604] Timer tick, asking Buildbucket for the build status
[03:10:41.723] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:41.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:80:0) after 1m0s
[03:11:41.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:80:0)
[03:11:41.749] Timer tick, asking Buildbucket for the build status
[03:11:41.811] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:41.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:81:0) after 1m0s
[03:12:41.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:81:0)
[03:12:41.833] Timer tick, asking Buildbucket for the build status
[03:12:41.914] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:41.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:82:0) after 1m0s
[03:13:41.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:82:0)
[03:13:41.941] Timer tick, asking Buildbucket for the build status
[03:13:41.994] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:41.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:83:0) after 1m0s
[03:14:42.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:83:0)
[03:14:42.071] Timer tick, asking Buildbucket for the build status
[03:14:42.154] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:42.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:84:0) after 1m0s
[03:15:42.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:84:0)
[03:15:42.179] Timer tick, asking Buildbucket for the build status
[03:15:42.423] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:42.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:85:0) after 1m0s
[03:16:42.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:85:0)
[03:16:42.546] Timer tick, asking Buildbucket for the build status
[03:16:42.602] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:42.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:86:0) after 1m0s
[03:17:42.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:86:0)
[03:17:42.655] Timer tick, asking Buildbucket for the build status
[03:17:42.715] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:42.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:87:0) after 1m0s
[03:18:42.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:87:0)
[03:18:42.736] Timer tick, asking Buildbucket for the build status
[03:18:42.841] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:42.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:88:0) after 1m0s
[03:19:42.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:88:0)
[03:19:42.956] Timer tick, asking Buildbucket for the build status
[03:19:43.042] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:43.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:89:0) after 1m0s
[03:20:43.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:89:0)
[03:20:43.121] Timer tick, asking Buildbucket for the build status
[03:20:43.240] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:43.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:90:0) after 1m0s
[03:21:43.304] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:90:0)
[03:21:43.304] Timer tick, asking Buildbucket for the build status
[03:21:43.585] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:43.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:91:0) after 1m0s
[03:22:43.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:91:0)
[03:22:43.679] Timer tick, asking Buildbucket for the build status
[03:22:43.771] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:43.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:92:0) after 1m0s
[03:23:43.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:92:0)
[03:23:43.846] Timer tick, asking Buildbucket for the build status
[03:23:43.933] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:43.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:93:0) after 1m0s
[03:24:43.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:93:0)
[03:24:43.976] Timer tick, asking Buildbucket for the build status
[03:24:44.033] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:44.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:94:0) after 1m0s
[03:25:44.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:94:0)
[03:25:44.087] Timer tick, asking Buildbucket for the build status
[03:25:44.172] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:44.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:95:0) after 1m0s
[03:26:44.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:95:0)
[03:26:44.286] Timer tick, asking Buildbucket for the build status
[03:26:44.349] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:44.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:96:0) after 1m0s
[03:27:44.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:96:0)
[03:27:44.389] Timer tick, asking Buildbucket for the build status
[03:27:44.533] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:44.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:97:0) after 1m0s
[03:28:44.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:97:0)
[03:28:44.555] Timer tick, asking Buildbucket for the build status
[03:28:44.626] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:44.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:98:0) after 1m0s
[03:29:44.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:98:0)
[03:29:44.655] Timer tick, asking Buildbucket for the build status
[03:29:44.821] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:44.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:99:0) after 1m0s
[03:30:44.860] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:99:0)
[03:30:44.860] Timer tick, asking Buildbucket for the build status
[03:30:45.005] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:45.005] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:100:0) after 1m0s
[03:31:45.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:100:0)
[03:31:45.107] Timer tick, asking Buildbucket for the build status
[03:31:45.982] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:45.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:101:0) after 1m0s
[03:32:46.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:101:0)
[03:32:46.005] Timer tick, asking Buildbucket for the build status
[03:32:46.222] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:102:0) after 1m0s
[03:33:46.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:102:0)
[03:33:46.308] Timer tick, asking Buildbucket for the build status
[03:33:46.364] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:46.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:103:0) after 1m0s
[03:34:46.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:103:0)
[03:34:46.404] Timer tick, asking Buildbucket for the build status
[03:34:46.456] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:46.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:104:0) after 1m0s
[03:35:46.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:104:0)
[03:35:46.482] Timer tick, asking Buildbucket for the build status
[03:35:46.552] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:46.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:105:0) after 1m0s
[03:36:46.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:105:0)
[03:36:46.578] Timer tick, asking Buildbucket for the build status
[03:36:46.707] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:46.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:106:0) after 1m0s
[03:37:46.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:106:0)
[03:37:46.730] Timer tick, asking Buildbucket for the build status
[03:37:46.782] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:46.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:107:0) after 1m0s
[03:38:46.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:107:0)
[03:38:46.810] Timer tick, asking Buildbucket for the build status
[03:38:46.863] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:46.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:108:0) after 1m0s
[03:39:46.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:108:0)
[03:39:46.888] Timer tick, asking Buildbucket for the build status
[03:39:47.070] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:47.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:109:0) after 1m0s
[03:40:47.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:109:0)
[03:40:47.095] Timer tick, asking Buildbucket for the build status
[03:40:47.275] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:47.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:110:0) after 1m0s
[03:41:47.311] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:110:0)
[03:41:47.311] Timer tick, asking Buildbucket for the build status
[03:41:47.364] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:47.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:111:0) after 1m0s
[03:42:47.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:111:0)
[03:42:47.390] Timer tick, asking Buildbucket for the build status
[03:42:47.452] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:47.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:112:0) after 1m0s
[03:43:47.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:112:0)
[03:43:47.475] Timer tick, asking Buildbucket for the build status
[03:43:47.524] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:47.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:113:0) after 1m0s
[03:44:47.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:113:0)
[03:44:47.602] Timer tick, asking Buildbucket for the build status
[03:44:47.823] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:47.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:114:0) after 1m0s
[03:45:47.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:114:0)
[03:45:47.850] Timer tick, asking Buildbucket for the build status
[03:45:47.899] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:47.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:115:0) after 1m0s
[03:46:47.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:115:0)
[03:46:47.920] Timer tick, asking Buildbucket for the build status
[03:46:47.978] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:47.978] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:116:0) after 1m0s
[03:47:48.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:116:0)
[03:47:48.001] Timer tick, asking Buildbucket for the build status
[03:47:48.056] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:48.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:117:0) after 1m0s
[03:48:48.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:117:0)
[03:48:48.079] Timer tick, asking Buildbucket for the build status
[03:48:51.190] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:51.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:118:0) after 1m0s
[03:49:51.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:118:0)
[03:49:51.213] Timer tick, asking Buildbucket for the build status
[03:49:51.271] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:51.271] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:119:0) after 1m0s
[03:50:51.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:119:0)
[03:50:51.294] Timer tick, asking Buildbucket for the build status
[03:50:51.377] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:51.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:120:0) after 1m0s
[03:51:51.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:120:0)
[03:51:51.401] Timer tick, asking Buildbucket for the build status
[03:51:51.634] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:51.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:121:0) after 1m0s
[03:52:51.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:121:0)
[03:52:51.686] Timer tick, asking Buildbucket for the build status
[03:52:51.746] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:51.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:122:0) after 1m0s
[03:53:51.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:122:0)
[03:53:51.895] Timer tick, asking Buildbucket for the build status
[03:53:51.948] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:51.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:123:0) after 1m0s
[03:54:52.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:123:0)
[03:54:52.081] Timer tick, asking Buildbucket for the build status
[03:54:52.139] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:52.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:124:0) after 1m0s
[03:55:52.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:124:0)
[03:55:52.164] Timer tick, asking Buildbucket for the build status
[03:55:52.219] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:52.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:125:0) after 1m0s
[03:56:52.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:125:0)
[03:56:52.301] Timer tick, asking Buildbucket for the build status
[03:56:52.591] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:52.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:126:0) after 1m0s
[03:57:52.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:126:0)
[03:57:52.696] Timer tick, asking Buildbucket for the build status
[03:57:52.760] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:52.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:127:0) after 1m0s
[03:58:52.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:127:0)
[03:58:52.790] Timer tick, asking Buildbucket for the build status
[03:58:52.844] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:52.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:128:0) after 1m0s
[03:59:53.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:128:0)
[03:59:53.014] Timer tick, asking Buildbucket for the build status
[03:59:53.091] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:53.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:129:0) after 1m0s
[04:00:53.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:129:0)
[04:00:53.225] Timer tick, asking Buildbucket for the build status
[04:00:53.392] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:53.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:130:0) after 1m0s
[04:01:53.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:130:0)
[04:01:53.555] Timer tick, asking Buildbucket for the build status
[04:01:53.638] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:53.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:131:0) after 1m0s
[04:02:53.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:131:0)
[04:02:53.769] Timer tick, asking Buildbucket for the build status
[04:02:53.819] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:53.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:132:0) after 1m0s
[04:03:53.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:132:0)
[04:03:53.953] Timer tick, asking Buildbucket for the build status
[04:03:54.148] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:54.148] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:133:0) after 1m0s
[04:04:54.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:133:0)
[04:04:54.288] Timer tick, asking Buildbucket for the build status
[04:04:54.379] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:54.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:134:0) after 1m0s
[04:05:54.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:134:0)
[04:05:54.501] Timer tick, asking Buildbucket for the build status
[04:05:54.619] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:54.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:135:0) after 1m0s
[04:06:54.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:135:0)
[04:06:54.737] Timer tick, asking Buildbucket for the build status
[04:06:54.793] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:54.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:136:0) after 1m0s
[04:07:54.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:136:0)
[04:07:54.879] Timer tick, asking Buildbucket for the build status
[04:07:54.944] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:54.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:137:0) after 1m0s
[04:08:55.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:137:0)
[04:08:55.137] Timer tick, asking Buildbucket for the build status
[04:08:55.202] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:55.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:138:0) after 1m0s
[04:09:55.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:138:0)
[04:09:55.330] Timer tick, asking Buildbucket for the build status
[04:09:55.381] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:55.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:139:0) after 1m0s
[04:10:55.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:139:0)
[04:10:55.507] Timer tick, asking Buildbucket for the build status
[04:10:55.571] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:55.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:140:0) after 1m0s
[04:11:55.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:140:0)
[04:11:55.694] Timer tick, asking Buildbucket for the build status
[04:11:55.767] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:55.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:141:0) after 1m0s
[04:12:55.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:141:0)
[04:12:55.862] Timer tick, asking Buildbucket for the build status
[04:12:55.914] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:142:0) after 1m0s
[04:13:56.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:142:0)
[04:13:56.046] Timer tick, asking Buildbucket for the build status
[04:13:56.133] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:56.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:143:0) after 1m0s
[04:14:56.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:143:0)
[04:14:56.325] Timer tick, asking Buildbucket for the build status
[04:14:56.438] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:56.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:144:0) after 1m0s
[04:15:56.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:144:0)
[04:15:56.565] Timer tick, asking Buildbucket for the build status
[04:15:56.787] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:56.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:145:0) after 1m0s
[04:16:56.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:145:0)
[04:16:56.893] Timer tick, asking Buildbucket for the build status
[04:16:56.958] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:56.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:146:0) after 1m0s
[04:17:57.080] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:146:0)
[04:17:57.080] Timer tick, asking Buildbucket for the build status
[04:17:57.134] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:57.134] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:147:0) after 1m0s
[04:18:57.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:147:0)
[04:18:57.269] Timer tick, asking Buildbucket for the build status
[04:18:57.353] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:57.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:148:0) after 1m0s
[04:19:57.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:148:0)
[04:19:57.422] Timer tick, asking Buildbucket for the build status
[04:19:57.482] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:149:0) after 1m0s
[04:20:57.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:149:0)
[04:20:57.598] Timer tick, asking Buildbucket for the build status
[04:20:57.660] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:57.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:150:0) after 1m0s
[04:21:57.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:150:0)
[04:21:57.777] Timer tick, asking Buildbucket for the build status
[04:21:57.850] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:57.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:151:0) after 1m0s
[04:22:57.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:151:0)
[04:22:57.970] Timer tick, asking Buildbucket for the build status
[04:22:58.073] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:58.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:152:0) after 1m0s
[04:23:58.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:152:0)
[04:23:58.224] Timer tick, asking Buildbucket for the build status
[04:23:58.297] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:58.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:153:0) after 1m0s
[04:24:58.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:153:0)
[04:24:58.408] Timer tick, asking Buildbucket for the build status
[04:24:58.468] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:58.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:154:0) after 1m0s
[04:25:58.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:154:0)
[04:25:58.601] Timer tick, asking Buildbucket for the build status
[04:25:58.694] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:58.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:155:0) after 1m0s
[04:26:58.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:155:0)
[04:26:58.783] Timer tick, asking Buildbucket for the build status
[04:26:58.899] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:58.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:156:0) after 1m0s
[04:27:58.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:156:0)
[04:27:58.946] Timer tick, asking Buildbucket for the build status
[04:27:59.230] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:59.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:157:0) after 1m0s
[04:28:59.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:157:0)
[04:28:59.268] Timer tick, asking Buildbucket for the build status
[04:28:59.421] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:59.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:158:0) after 1m0s
[04:29:59.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:158:0)
[04:29:59.460] Timer tick, asking Buildbucket for the build status
[04:29:59.514] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:59.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:159:0) after 1m0s
[04:30:59.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:159:0)
[04:30:59.542] Timer tick, asking Buildbucket for the build status
[04:30:59.621] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:59.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:160:0) after 1m0s
[04:31:59.716] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:160:0)
[04:31:59.716] Timer tick, asking Buildbucket for the build status
[04:31:59.856] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:59.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:161:0) after 1m0s
[04:32:59.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:161:0)
[04:32:59.998] Timer tick, asking Buildbucket for the build status
[04:33:00.169] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:162:0) after 1m0s
[04:34:00.329] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:162:0)
[04:34:00.329] Timer tick, asking Buildbucket for the build status
[04:34:00.400] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:00.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:163:0) after 1m0s
[04:35:00.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:163:0)
[04:35:00.550] Timer tick, asking Buildbucket for the build status
[04:35:00.611] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:00.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:164:0) after 1m0s
[04:36:00.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:164:0)
[04:36:00.701] Timer tick, asking Buildbucket for the build status
[04:36:01.036] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:01.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:165:0) after 1m0s
[04:37:01.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:165:0)
[04:37:01.105] Timer tick, asking Buildbucket for the build status
[04:37:01.162] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:01.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:166:0) after 1m0s
[04:38:01.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:166:0)
[04:38:01.210] Timer tick, asking Buildbucket for the build status
[04:38:01.451] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:01.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:167:0) after 1m0s
[04:39:01.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:167:0)
[04:39:01.593] Timer tick, asking Buildbucket for the build status
[04:39:01.822] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:01.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:168:0) after 1m0s
[04:40:01.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:168:0)
[04:40:01.877] Timer tick, asking Buildbucket for the build status
[04:40:04.991] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:04.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:169:0) after 1m0s
[04:41:05.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:169:0)
[04:41:05.069] Timer tick, asking Buildbucket for the build status
[04:41:05.339] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:05.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:170:0) after 1m0s
[04:42:05.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:170:0)
[04:42:05.476] Timer tick, asking Buildbucket for the build status
[04:42:05.545] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:05.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:171:0) after 1m0s
[04:43:05.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:171:0)
[04:43:05.711] Timer tick, asking Buildbucket for the build status
[04:43:05.895] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:05.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:172:0) after 1m0s
[04:44:06.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:172:0)
[04:44:06.040] Timer tick, asking Buildbucket for the build status
[04:44:06.233] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:06.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:173:0) after 1m0s
[04:45:06.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:173:0)
[04:45:06.366] Timer tick, asking Buildbucket for the build status
[04:45:06.501] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:06.501] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:174:0) after 1m0s
[04:46:06.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:174:0)
[04:46:06.651] Timer tick, asking Buildbucket for the build status
[04:46:06.851] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:06.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:175:0) after 1m0s
[04:47:06.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:175:0)
[04:47:06.928] Timer tick, asking Buildbucket for the build status
[04:47:06.963] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:06.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:176:0) after 1m0s
[04:48:07.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:176:0)
[04:48:07.107] Timer tick, asking Buildbucket for the build status
[04:48:07.166] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:07.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:177:0) after 1m0s
[04:49:07.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:177:0)
[04:49:07.296] Timer tick, asking Buildbucket for the build status
[04:49:07.349] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:07.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:178:0) after 1m0s
[04:50:07.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:178:0)
[04:50:07.484] Timer tick, asking Buildbucket for the build status
[04:50:07.547] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:07.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:179:0) after 1m0s
[04:51:07.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:179:0)
[04:51:07.678] Timer tick, asking Buildbucket for the build status
[04:51:07.787] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:07.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:180:0) after 1m0s
[04:52:07.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:180:0)
[04:52:07.819] Timer tick, asking Buildbucket for the build status
[04:52:08.086] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:08.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:181:0) after 1m0s
[04:53:08.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:181:0)
[04:53:08.112] Timer tick, asking Buildbucket for the build status
[04:53:08.149] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:08.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:182:0) after 1m0s
[04:54:08.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:182:0)
[04:54:08.272] Timer tick, asking Buildbucket for the build status
[04:54:08.357] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:08.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:183:0) after 1m0s
[04:55:08.389] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:183:0)
[04:55:08.389] Timer tick, asking Buildbucket for the build status
[04:55:08.445] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:08.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:184:0) after 1m0s
[04:56:08.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:184:0)
[04:56:08.469] Timer tick, asking Buildbucket for the build status
[04:56:08.671] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:08.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:185:0) after 1m0s
[04:57:08.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:185:0)
[04:57:08.696] Timer tick, asking Buildbucket for the build status
[04:57:08.747] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:08.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:186:0) after 1m0s
[04:58:08.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:186:0)
[04:58:08.877] Timer tick, asking Buildbucket for the build status
[04:58:08.950] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:08.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:187:0) after 1m0s
[04:59:09.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:187:0)
[04:59:09.117] Timer tick, asking Buildbucket for the build status
[04:59:09.193] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:09.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:188:0) after 1m0s
[05:00:09.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:188:0)
[05:00:09.248] Timer tick, asking Buildbucket for the build status
[05:00:09.354] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:09.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:189:0) after 1m0s
[05:01:09.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:189:0)
[05:01:09.384] Timer tick, asking Buildbucket for the build status
[05:01:09.520] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:09.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:190:0) after 1m0s
[05:02:09.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:190:0)
[05:02:09.543] Timer tick, asking Buildbucket for the build status
[05:02:09.598] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:09.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:191:0) after 1m0s
[05:03:09.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:191:0)
[05:03:09.679] Timer tick, asking Buildbucket for the build status
[05:03:09.736] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:09.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:192:0) after 1m0s
[05:04:09.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:192:0)
[05:04:09.812] Timer tick, asking Buildbucket for the build status
[05:04:09.886] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:09.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:193:0) after 1m0s
[05:05:10.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:193:0)
[05:05:10.023] Timer tick, asking Buildbucket for the build status
[05:05:10.096] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:10.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:194:0) after 1m0s
[05:06:10.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:194:0)
[05:06:10.148] Timer tick, asking Buildbucket for the build status
[05:06:10.206] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:10.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:195:0) after 1m0s
[05:07:10.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:195:0)
[05:07:10.299] Timer tick, asking Buildbucket for the build status
[05:07:10.337] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:10.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:196:0) after 1m0s
[05:08:10.426] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:196:0)
[05:08:10.426] Timer tick, asking Buildbucket for the build status
[05:08:10.627] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:10.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:197:0) after 1m0s
[05:09:10.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:197:0)
[05:09:10.730] Timer tick, asking Buildbucket for the build status
[05:09:10.934] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:10.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:198:0) after 1m0s
[05:10:10.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:198:0)
[05:10:10.958] Timer tick, asking Buildbucket for the build status
[05:10:11.138] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:11.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:199:0) after 1m0s
[05:11:11.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:199:0)
[05:11:11.159] Timer tick, asking Buildbucket for the build status
[05:11:11.205] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:11.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:200:0) after 1m0s
[05:12:11.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:200:0)
[05:12:11.328] Timer tick, asking Buildbucket for the build status
[05:12:11.402] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:11.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:201:0) after 1m0s
[05:13:11.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:201:0)
[05:13:11.424] Timer tick, asking Buildbucket for the build status
[05:13:11.484] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:11.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:202:0) after 1m0s
[05:14:11.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:202:0)
[05:14:11.520] Timer tick, asking Buildbucket for the build status
[05:14:11.572] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:11.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:203:0) after 1m0s
[05:15:11.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:203:0)
[05:15:11.622] Timer tick, asking Buildbucket for the build status
[05:15:11.974] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:11.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:204:0) after 1m0s
[05:16:12.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:204:0)
[05:16:12.021] Timer tick, asking Buildbucket for the build status
[05:16:12.066] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:12.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:205:0) after 1m0s
[05:17:12.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:205:0)
[05:17:12.102] Timer tick, asking Buildbucket for the build status
[05:17:12.166] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:12.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:206:0) after 1m0s
[05:18:12.193] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:206:0)
[05:18:12.193] Timer tick, asking Buildbucket for the build status
[05:18:12.263] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:12.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:207:0) after 1m0s
[05:19:12.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:207:0)
[05:19:12.351] Timer tick, asking Buildbucket for the build status
[05:19:12.416] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:12.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:208:0) after 1m0s
[05:20:12.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:208:0)
[05:20:12.441] Timer tick, asking Buildbucket for the build status
[05:20:12.496] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:12.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:209:0) after 1m0s
[05:21:12.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:209:0)
[05:21:12.523] Timer tick, asking Buildbucket for the build status
[05:21:12.700] Build 8943510804358879296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:12.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9108940866508484288:210:0) after 1m0s
[05:21:13.451] Received PubSub notification, asking Buildbucket for the build status
[05:21:13.510] Build 8943510804358879296: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[05:21:13.510] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1529212871696835",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1529200469589110",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8943510804358879296",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"f30471c585171ddd4240258f35b9f31300da7e0b\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"task_result\": {\"run_id\": \"3e2444effd1fa811\", \"created_ts\": \"2018-06-17T01:54:29.890813\", \"try_number\": \"1\", \"bot_version\": \"a05add8da0279746f7894db2d776781bf284a02fe59235097cc09761bd9a0330\", \"task_id\": \"3e2444effd1fa810\", \"internal_failure\": true, \"current_task_slice\": \"0\", \"bot_dimensions\": [{\"value\": [\"Windows deterministic\"], \"key\": \"builder\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"swarm2173-c4\"], \"key\": \"id\"}, {\"value\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"key\": \"image\"}, {\"value\": [\"high\"], \"key\": \"integrity\"}, {\"value\": [\"en_US.cp1252\"], \"key\": \"locale\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"key\": \"os\"}, {\"value\": [\"luci.chromium.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3649-5aeacfe\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"server_versions\": [\"3649-5aeacfe\"], \"state\": \"BOT_DIED\", \"name\": \"bb-8943510804358879296-chromium-Windows deterministic\", \"abandoned_ts\": \"2018-06-17T05:21:11.696835\", \"failure\": false, \"costs_usd\": [2.2068180476970434], \"modified_ts\": \"2018-06-17T05:21:11.696835\", \"user\": \"\", \"started_ts\": \"2018-06-17T02:19:10.682834\", \"tags\": [\"build_address:luci.chromium.ci/Windows deterministic/50\", \"buildbucket_bucket:luci.chromium.ci\", \"buildbucket_build_id:8943510804358879296\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864\", \"builder:Windows deterministic\", \"buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b\", \"cores:8\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8943510804358879296/+/annotations\", \"luci_project:chromium\", \"os:Windows-10\", \"pool:luci.chromium.ci\", \"priority:60\", \"recipe_name:swarming/deterministic_build\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9108940866508484288\", \"scheduler_job_id:chromium/Windows deterministic\", \"service_account:chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com\", \"swarming.pool.template:skip\", \"swarming.pool.version:7b1b5d239a2e04e83d3627884ca58c970e37b2b0\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"bot_id\": \"swarm2173-c4\"}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1529201950682834",
"status": "COMPLETED",
"status_changed_ts": "1529212872403396",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/50",
"builder:Windows deterministic",
"buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9108940866508484288",
"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/50",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8943510804358879296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:2a8c11ce5d733cead8b6ce80c31bfed950c5e864",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/f30471c585171ddd4240258f35b9f31300da7e0b",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f30471c585171ddd4240258f35b9f31300da7e0b",
"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/8943510804358879296/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:60",
"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:9108940866508484288",
"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:7b1b5d239a2e04e83d3627884ca58c970e37b2b0",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3e2444effd1fa810",
"user_agent:luci-scheduler"
],
"updated_ts": "1529212872405925",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/50",
"utcnow_ts": "1529212873495082"
}
}
[05:21:13.510] Invocation finished in 3h26m45.354816038s with status FAILED