[19:56:46.292] New invocation is queued and will start shortly
[19:56:47.538] Starting the invocation (attempt 1)
[19:56:47.569] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:56:47.570] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:56:47.570] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9101443822710493936",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9101443822710493936",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"gitiles_ref:refs/heads/master"
]
}
[19:56:51.662] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536350207680619",
"id": "8936013760590438864",
"lease_expiration_ts": "1536494211100323",
"lease_key": "1306380575",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1536350211451110",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10009",
"builder:Windows deterministic",
"buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101443822710493936",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"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/10009",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8936013760590438864",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"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/8936013760590438864/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101443822710493936",
"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:d35ad0202050590393072590ac52b8068d1c49f9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fce6d529c48e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1536350211451892",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10009",
"utcnow_ts": "1536350211569514"
}
}
[19:56:51.662] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10009
[19:56:51.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:2:0) after 1m0s
[19:57:51.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:2:0)
[19:57:51.678] Timer tick, asking Buildbucket for the build status
[19:57:51.784] Build 8936013760590438864: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:57:51.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:3:0) after 1m0s
[19:58:34.494] Received PubSub notification, asking Buildbucket for the build status
[19:58:34.594] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:51.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:3:0)
[19:58:51.864] Timer tick, asking Buildbucket for the build status
[19:58:51.948] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:51.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:5:0) after 1m0s
[19:59:51.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:5:0)
[19:59:51.970] Timer tick, asking Buildbucket for the build status
[19:59:52.014] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:52.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:6:0) after 1m0s
[20:00:52.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:6:0)
[20:00:52.255] Timer tick, asking Buildbucket for the build status
[20:00:52.401] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:7:0) after 1m0s
[20:01:52.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:7:0)
[20:01:52.887] Timer tick, asking Buildbucket for the build status
[20:01:53.001] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:53.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:8:0) after 1m0s
[20:02:53.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:8:0)
[20:02:53.444] Timer tick, asking Buildbucket for the build status
[20:02:53.492] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:53.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:9:0) after 1m0s
[20:03:54.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:9:0)
[20:03:54.968] Timer tick, asking Buildbucket for the build status
[20:03:55.018] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:55.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:10:0) after 1m0s
[20:04:55.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:10:0)
[20:04:55.117] Timer tick, asking Buildbucket for the build status
[20:04:55.259] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:55.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:11:0) after 1m0s
[20:05:55.278] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:11:0)
[20:05:55.278] Timer tick, asking Buildbucket for the build status
[20:05:55.355] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:55.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:12:0) after 1m0s
[20:06:55.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:12:0)
[20:06:55.374] Timer tick, asking Buildbucket for the build status
[20:06:55.447] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:55.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:13:0) after 1m0s
[20:07:55.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:13:0)
[20:07:55.544] Timer tick, asking Buildbucket for the build status
[20:07:55.586] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:55.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:14:0) after 1m0s
[20:08:55.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:14:0)
[20:08:55.607] Timer tick, asking Buildbucket for the build status
[20:08:55.675] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:55.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:15:0) after 1m0s
[20:09:56.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:15:0)
[20:09:56.247] Timer tick, asking Buildbucket for the build status
[20:09:56.310] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:56.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:16:0) after 1m0s
[20:10:56.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:16:0)
[20:10:56.336] Timer tick, asking Buildbucket for the build status
[20:10:56.469] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:56.469] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:17:0) after 1m0s
[20:11:57.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:17:0)
[20:11:57.086] Timer tick, asking Buildbucket for the build status
[20:11:57.141] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:57.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:18:0) after 1m0s
[20:12:58.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:18:0)
[20:12:58.877] Timer tick, asking Buildbucket for the build status
[20:12:58.990] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:58.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:19:0) after 1m0s
[20:13:59.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:19:0)
[20:13:59.274] Timer tick, asking Buildbucket for the build status
[20:13:59.348] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:59.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:20:0) after 1m0s
[20:15:00.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:20:0)
[20:15:00.257] Timer tick, asking Buildbucket for the build status
[20:15:00.328] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:00.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:21:0) after 1m0s
[20:16:01.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:21:0)
[20:16:01.459] Timer tick, asking Buildbucket for the build status
[20:16:01.524] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:01.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:22:0) after 1m0s
[20:17:01.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:22:0)
[20:17:01.575] Timer tick, asking Buildbucket for the build status
[20:17:01.716] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:01.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:23:0) after 1m0s
[20:18:01.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:23:0)
[20:18:01.737] Timer tick, asking Buildbucket for the build status
[20:18:01.849] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:01.849] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:24:0) after 1m0s
[20:19:01.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:24:0)
[20:19:01.868] Timer tick, asking Buildbucket for the build status
[20:19:01.954] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:01.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:25:0) after 1m0s
[20:20:02.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:25:0)
[20:20:02.460] Timer tick, asking Buildbucket for the build status
[20:20:04.598] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:04.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:26:0) after 1m0s
[20:21:04.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:26:0)
[20:21:04.626] Timer tick, asking Buildbucket for the build status
[20:21:04.722] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:04.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:27:0) after 1m0s
[20:22:05.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:27:0)
[20:22:05.322] Timer tick, asking Buildbucket for the build status
[20:22:05.392] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:05.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:28:0) after 1m0s
[20:23:05.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:28:0)
[20:23:05.547] Timer tick, asking Buildbucket for the build status
[20:23:05.587] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:05.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:29:0) after 1m0s
[20:24:05.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:29:0)
[20:24:05.653] Timer tick, asking Buildbucket for the build status
[20:24:05.704] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:05.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:30:0) after 1m0s
[20:25:06.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:30:0)
[20:25:06.572] Timer tick, asking Buildbucket for the build status
[20:25:06.627] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:06.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:31:0) after 1m0s
[20:26:07.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:31:0)
[20:26:07.013] Timer tick, asking Buildbucket for the build status
[20:26:07.208] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:07.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:32:0) after 1m0s
[20:27:07.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:32:0)
[20:27:07.229] Timer tick, asking Buildbucket for the build status
[20:27:07.515] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:07.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:33:0) after 1m0s
[20:28:07.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:33:0)
[20:28:07.536] Timer tick, asking Buildbucket for the build status
[20:28:07.598] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:07.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:34:0) after 1m0s
[20:29:09.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:34:0)
[20:29:09.066] Timer tick, asking Buildbucket for the build status
[20:29:09.123] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:09.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:35:0) after 1m0s
[20:30:10.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:35:0)
[20:30:10.250] Timer tick, asking Buildbucket for the build status
[20:30:10.321] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:10.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:36:0) after 1m0s
[20:31:11.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:36:0)
[20:31:11.461] Timer tick, asking Buildbucket for the build status
[20:31:11.545] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:11.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:37:0) after 1m0s
[20:32:12.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:37:0)
[20:32:12.721] Timer tick, asking Buildbucket for the build status
[20:32:12.786] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:12.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:38:0) after 1m0s
[20:33:14.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:38:0)
[20:33:14.064] Timer tick, asking Buildbucket for the build status
[20:33:14.241] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:14.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:39:0) after 1m0s
[20:34:15.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:39:0)
[20:34:15.195] Timer tick, asking Buildbucket for the build status
[20:34:15.261] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:40:0) after 1m0s
[20:35:15.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:40:0)
[20:35:15.281] Timer tick, asking Buildbucket for the build status
[20:35:15.336] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:15.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:41:0) after 1m0s
[20:36:15.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:41:0)
[20:36:15.365] Timer tick, asking Buildbucket for the build status
[20:36:15.425] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:15.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:42:0) after 1m0s
[20:37:15.444] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:42:0)
[20:37:15.444] Timer tick, asking Buildbucket for the build status
[20:37:15.493] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:15.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:43:0) after 1m0s
[20:38:15.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:43:0)
[20:38:15.514] Timer tick, asking Buildbucket for the build status
[20:38:15.643] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:15.643] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:44:0) after 1m0s
[20:39:15.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:44:0)
[20:39:15.677] Timer tick, asking Buildbucket for the build status
[20:39:15.795] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:15.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:45:0) after 1m0s
[20:40:15.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:45:0)
[20:40:15.814] Timer tick, asking Buildbucket for the build status
[20:40:15.873] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:15.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:46:0) after 1m0s
[20:41:15.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:46:0)
[20:41:15.904] Timer tick, asking Buildbucket for the build status
[20:41:15.969] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:15.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:47:0) after 1m0s
[20:42:15.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:47:0)
[20:42:15.991] Timer tick, asking Buildbucket for the build status
[20:42:16.083] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:16.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:48:0) after 1m0s
[20:43:16.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:48:0)
[20:43:16.175] Timer tick, asking Buildbucket for the build status
[20:43:16.264] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:16.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:49:0) after 1m0s
[20:44:16.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:49:0)
[20:44:16.286] Timer tick, asking Buildbucket for the build status
[20:44:16.491] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:16.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:50:0) after 1m0s
[20:45:16.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:50:0)
[20:45:16.566] Timer tick, asking Buildbucket for the build status
[20:45:16.607] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:16.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:51:0) after 1m0s
[20:46:16.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:51:0)
[20:46:16.633] Timer tick, asking Buildbucket for the build status
[20:46:16.690] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:16.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:52:0) after 1m0s
[20:47:16.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:52:0)
[20:47:16.715] Timer tick, asking Buildbucket for the build status
[20:47:16.894] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:16.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:53:0) after 1m0s
[20:48:16.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:53:0)
[20:48:16.916] Timer tick, asking Buildbucket for the build status
[20:48:16.987] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:16.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:54:0) after 1m0s
[20:49:17.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:54:0)
[20:49:17.007] Timer tick, asking Buildbucket for the build status
[20:49:17.107] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:17.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:55:0) after 1m0s
[20:50:17.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:55:0)
[20:50:17.126] Timer tick, asking Buildbucket for the build status
[20:50:17.211] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:17.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:56:0) after 1m0s
[20:51:17.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:56:0)
[20:51:17.269] Timer tick, asking Buildbucket for the build status
[20:51:17.303] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:57:0) after 1m0s
[20:52:17.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:57:0)
[20:52:17.323] Timer tick, asking Buildbucket for the build status
[20:52:17.415] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:17.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:58:0) after 1m0s
[20:53:17.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:58:0)
[20:53:17.439] Timer tick, asking Buildbucket for the build status
[20:53:17.478] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:17.478] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:59:0) after 1m0s
[20:54:17.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:59:0)
[20:54:17.540] Timer tick, asking Buildbucket for the build status
[20:54:17.632] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:17.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:60:0) after 1m0s
[20:55:17.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:60:0)
[20:55:17.669] Timer tick, asking Buildbucket for the build status
[20:55:17.861] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:61:0) after 1m0s
[20:56:17.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:61:0)
[20:56:17.949] Timer tick, asking Buildbucket for the build status
[20:56:18.040] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:18.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:62:0) after 1m0s
[20:57:18.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:62:0)
[20:57:18.076] Timer tick, asking Buildbucket for the build status
[20:57:18.264] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:18.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:63:0) after 1m0s
[20:58:18.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:63:0)
[20:58:18.286] Timer tick, asking Buildbucket for the build status
[20:58:18.345] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:18.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:64:0) after 1m0s
[20:59:18.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:64:0)
[20:59:18.370] Timer tick, asking Buildbucket for the build status
[20:59:18.438] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:18.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:65:0) after 1m0s
[21:00:18.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:65:0)
[21:00:18.460] Timer tick, asking Buildbucket for the build status
[21:00:18.510] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:18.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:66:0) after 1m0s
[21:01:18.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:66:0)
[21:01:18.542] Timer tick, asking Buildbucket for the build status
[21:01:18.794] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:18.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:67:0) after 1m0s
[21:02:18.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:67:0)
[21:02:18.843] Timer tick, asking Buildbucket for the build status
[21:02:18.930] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:18.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:68:0) after 1m0s
[21:03:18.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:68:0)
[21:03:18.979] Timer tick, asking Buildbucket for the build status
[21:03:19.072] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:19.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:69:0) after 1m0s
[21:04:19.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:69:0)
[21:04:19.101] Timer tick, asking Buildbucket for the build status
[21:04:19.147] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:19.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:70:0) after 1m0s
[21:05:19.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:70:0)
[21:05:19.170] Timer tick, asking Buildbucket for the build status
[21:05:19.310] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:19.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:71:0) after 1m0s
[21:06:19.345] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:71:0)
[21:06:19.345] Timer tick, asking Buildbucket for the build status
[21:06:19.405] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:19.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:72:0) after 1m0s
[21:07:19.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:72:0)
[21:07:19.428] Timer tick, asking Buildbucket for the build status
[21:07:19.463] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:19.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:73:0) after 1m0s
[21:08:19.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:73:0)
[21:08:19.482] Timer tick, asking Buildbucket for the build status
[21:08:19.537] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:19.537] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:74:0) after 1m0s
[21:09:19.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:74:0)
[21:09:19.596] Timer tick, asking Buildbucket for the build status
[21:09:19.735] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:19.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:75:0) after 1m0s
[21:10:19.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:75:0)
[21:10:19.758] Timer tick, asking Buildbucket for the build status
[21:10:19.998] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:19.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:76:0) after 1m0s
[21:11:20.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:76:0)
[21:11:20.017] Timer tick, asking Buildbucket for the build status
[21:11:20.159] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:20.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:77:0) after 1m0s
[21:12:20.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:77:0)
[21:12:20.178] Timer tick, asking Buildbucket for the build status
[21:12:20.252] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:20.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:78:0) after 1m0s
[21:13:20.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:78:0)
[21:13:20.292] Timer tick, asking Buildbucket for the build status
[21:13:20.767] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:20.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:79:0) after 1m0s
[21:14:20.793] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:79:0)
[21:14:20.793] Timer tick, asking Buildbucket for the build status
[21:14:21.076] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:21.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:80:0) after 1m0s
[21:15:21.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:80:0)
[21:15:21.112] Timer tick, asking Buildbucket for the build status
[21:15:21.199] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:21.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:81:0) after 1m0s
[21:16:21.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:81:0)
[21:16:21.219] Timer tick, asking Buildbucket for the build status
[21:16:21.379] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:21.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:82:0) after 1m0s
[21:17:21.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:82:0)
[21:17:21.453] Timer tick, asking Buildbucket for the build status
[21:17:21.496] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:21.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:83:0) after 1m0s
[21:18:21.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:83:0)
[21:18:21.519] Timer tick, asking Buildbucket for the build status
[21:18:21.674] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:21.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:84:0) after 1m0s
[21:19:21.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:84:0)
[21:19:21.698] Timer tick, asking Buildbucket for the build status
[21:19:21.744] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:21.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:85:0) after 1m0s
[21:20:21.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:85:0)
[21:20:21.767] Timer tick, asking Buildbucket for the build status
[21:20:22.021] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:22.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:86:0) after 1m0s
[21:21:22.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:86:0)
[21:21:22.044] Timer tick, asking Buildbucket for the build status
[21:21:22.115] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:87:0) after 1m0s
[21:22:22.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:87:0)
[21:22:22.302] Timer tick, asking Buildbucket for the build status
[21:22:22.404] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:22.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:88:0) after 1m0s
[21:23:22.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:88:0)
[21:23:22.428] Timer tick, asking Buildbucket for the build status
[21:23:22.477] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:22.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:89:0) after 1m0s
[21:24:22.498] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:89:0)
[21:24:22.498] Timer tick, asking Buildbucket for the build status
[21:24:22.571] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:22.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:90:0) after 1m0s
[21:25:22.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:90:0)
[21:25:22.594] Timer tick, asking Buildbucket for the build status
[21:25:22.653] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:22.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:91:0) after 1m0s
[21:26:22.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:91:0)
[21:26:22.789] Timer tick, asking Buildbucket for the build status
[21:26:22.857] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:22.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:92:0) after 1m0s
[21:27:22.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:92:0)
[21:27:22.882] Timer tick, asking Buildbucket for the build status
[21:27:22.957] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:22.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:93:0) after 1m0s
[21:28:22.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:93:0)
[21:28:22.979] Timer tick, asking Buildbucket for the build status
[21:28:23.016] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:23.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:94:0) after 1m0s
[21:29:23.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:94:0)
[21:29:23.071] Timer tick, asking Buildbucket for the build status
[21:29:23.198] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:23.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:95:0) after 1m0s
[21:30:23.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:95:0)
[21:30:23.245] Timer tick, asking Buildbucket for the build status
[21:30:23.310] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:23.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:96:0) after 1m0s
[21:31:23.421] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:96:0)
[21:31:23.421] Timer tick, asking Buildbucket for the build status
[21:31:23.508] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:23.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:97:0) after 1m0s
[21:32:23.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:97:0)
[21:32:23.530] Timer tick, asking Buildbucket for the build status
[21:32:23.570] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:23.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:98:0) after 1m0s
[21:33:23.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:98:0)
[21:33:23.595] Timer tick, asking Buildbucket for the build status
[21:33:23.661] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:23.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:99:0) after 1m0s
[21:34:23.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:99:0)
[21:34:23.685] Timer tick, asking Buildbucket for the build status
[21:34:23.724] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:23.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:100:0) after 1m0s
[21:35:23.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:100:0)
[21:35:23.747] Timer tick, asking Buildbucket for the build status
[21:35:23.816] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:23.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:101:0) after 1m0s
[21:36:23.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:101:0)
[21:36:23.841] Timer tick, asking Buildbucket for the build status
[21:36:23.943] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:23.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:102:0) after 1m0s
[21:37:24.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:102:0)
[21:37:24.004] Timer tick, asking Buildbucket for the build status
[21:37:24.095] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:24.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:103:0) after 1m0s
[21:38:24.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:103:0)
[21:38:24.174] Timer tick, asking Buildbucket for the build status
[21:38:24.263] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:24.263] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:104:0) after 1m0s
[21:39:24.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:104:0)
[21:39:24.288] Timer tick, asking Buildbucket for the build status
[21:39:24.365] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:24.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:105:0) after 1m0s
[21:40:24.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:105:0)
[21:40:24.400] Timer tick, asking Buildbucket for the build status
[21:40:24.443] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:24.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:106:0) after 1m0s
[21:41:24.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:106:0)
[21:41:24.480] Timer tick, asking Buildbucket for the build status
[21:41:24.585] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:24.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:107:0) after 1m0s
[21:42:24.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:107:0)
[21:42:24.608] Timer tick, asking Buildbucket for the build status
[21:42:24.639] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:24.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:108:0) after 1m0s
[21:43:24.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:108:0)
[21:43:24.663] Timer tick, asking Buildbucket for the build status
[21:43:24.720] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:24.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:109:0) after 1m0s
[21:44:24.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:109:0)
[21:44:24.757] Timer tick, asking Buildbucket for the build status
[21:44:24.795] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:24.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:110:0) after 1m0s
[21:45:24.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:110:0)
[21:45:24.819] Timer tick, asking Buildbucket for the build status
[21:45:24.896] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:24.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:111:0) after 1m0s
[21:46:24.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:111:0)
[21:46:24.925] Timer tick, asking Buildbucket for the build status
[21:46:24.963] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:24.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:112:0) after 1m0s
[21:47:24.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:112:0)
[21:47:24.993] Timer tick, asking Buildbucket for the build status
[21:47:25.066] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:25.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:113:0) after 1m0s
[21:48:25.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:113:0)
[21:48:25.102] Timer tick, asking Buildbucket for the build status
[21:48:25.185] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:25.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:114:0) after 1m0s
[21:49:25.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:114:0)
[21:49:25.205] Timer tick, asking Buildbucket for the build status
[21:49:25.243] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:25.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:115:0) after 1m0s
[21:50:25.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:115:0)
[21:50:25.269] Timer tick, asking Buildbucket for the build status
[21:50:25.344] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:25.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:116:0) after 1m0s
[21:51:25.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:116:0)
[21:51:25.367] Timer tick, asking Buildbucket for the build status
[21:51:25.425] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:25.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:117:0) after 1m0s
[21:52:25.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:117:0)
[21:52:25.451] Timer tick, asking Buildbucket for the build status
[21:52:25.503] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:25.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:118:0) after 1m0s
[21:53:25.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:118:0)
[21:53:25.526] Timer tick, asking Buildbucket for the build status
[21:53:25.605] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:25.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:119:0) after 1m0s
[21:54:25.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:119:0)
[21:54:25.630] Timer tick, asking Buildbucket for the build status
[21:54:25.995] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:25.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:120:0) after 1m0s
[21:55:26.020] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:120:0)
[21:55:26.020] Timer tick, asking Buildbucket for the build status
[21:55:26.088] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:26.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:121:0) after 1m0s
[21:56:26.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:121:0)
[21:56:26.109] Timer tick, asking Buildbucket for the build status
[21:56:26.162] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:26.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:122:0) after 1m0s
[21:57:26.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:122:0)
[21:57:26.184] Timer tick, asking Buildbucket for the build status
[21:57:26.408] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:26.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:123:0) after 1m0s
[21:58:26.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:123:0)
[21:58:26.434] Timer tick, asking Buildbucket for the build status
[21:58:26.549] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:26.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:124:0) after 1m0s
[21:59:26.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:124:0)
[21:59:26.576] Timer tick, asking Buildbucket for the build status
[21:59:26.647] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:26.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:125:0) after 1m0s
[22:00:26.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:125:0)
[22:00:26.681] Timer tick, asking Buildbucket for the build status
[22:00:26.721] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:26.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:126:0) after 1m0s
[22:01:26.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:126:0)
[22:01:26.747] Timer tick, asking Buildbucket for the build status
[22:01:26.845] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:26.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:127:0) after 1m0s
[22:02:26.883] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:127:0)
[22:02:26.883] Timer tick, asking Buildbucket for the build status
[22:02:26.949] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:26.949] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:128:0) after 1m0s
[22:03:26.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:128:0)
[22:03:26.978] Timer tick, asking Buildbucket for the build status
[22:03:27.048] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:27.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:129:0) after 1m0s
[22:04:27.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:129:0)
[22:04:27.125] Timer tick, asking Buildbucket for the build status
[22:04:27.175] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:27.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:130:0) after 1m0s
[22:05:27.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:130:0)
[22:05:27.199] Timer tick, asking Buildbucket for the build status
[22:05:27.257] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:27.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:131:0) after 1m0s
[22:06:27.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:131:0)
[22:06:27.321] Timer tick, asking Buildbucket for the build status
[22:06:27.600] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:27.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:132:0) after 1m0s
[22:07:27.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:132:0)
[22:07:27.717] Timer tick, asking Buildbucket for the build status
[22:07:27.792] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:27.792] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:133:0) after 1m0s
[22:08:27.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:133:0)
[22:08:27.817] Timer tick, asking Buildbucket for the build status
[22:08:27.934] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:27.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:134:0) after 1m0s
[22:09:28.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:134:0)
[22:09:28.025] Timer tick, asking Buildbucket for the build status
[22:09:28.086] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:28.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:135:0) after 1m0s
[22:10:28.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:135:0)
[22:10:28.110] Timer tick, asking Buildbucket for the build status
[22:10:28.193] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:28.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:136:0) after 1m0s
[22:11:28.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:136:0)
[22:11:28.281] Timer tick, asking Buildbucket for the build status
[22:11:28.321] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:28.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:137:0) after 1m0s
[22:12:28.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:137:0)
[22:12:28.345] Timer tick, asking Buildbucket for the build status
[22:12:28.423] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:28.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:138:0) after 1m0s
[22:13:28.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:138:0)
[22:13:28.449] Timer tick, asking Buildbucket for the build status
[22:13:28.493] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:28.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:139:0) after 1m0s
[22:14:28.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:139:0)
[22:14:28.520] Timer tick, asking Buildbucket for the build status
[22:14:28.588] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:28.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:140:0) after 1m0s
[22:15:28.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:140:0)
[22:15:28.612] Timer tick, asking Buildbucket for the build status
[22:15:28.680] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:28.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:141:0) after 1m0s
[22:16:28.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:141:0)
[22:16:28.740] Timer tick, asking Buildbucket for the build status
[22:16:28.907] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:28.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:142:0) after 1m0s
[22:17:28.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:142:0)
[22:17:28.932] Timer tick, asking Buildbucket for the build status
[22:17:28.997] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:28.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:143:0) after 1m0s
[22:18:29.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:143:0)
[22:18:29.019] Timer tick, asking Buildbucket for the build status
[22:18:29.244] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:29.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:144:0) after 1m0s
[22:19:29.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:144:0)
[22:19:29.274] Timer tick, asking Buildbucket for the build status
[22:19:29.357] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:29.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:145:0) after 1m0s
[22:20:29.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:145:0)
[22:20:29.378] Timer tick, asking Buildbucket for the build status
[22:20:29.493] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:29.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:146:0) after 1m0s
[22:21:29.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:146:0)
[22:21:29.532] Timer tick, asking Buildbucket for the build status
[22:21:29.567] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:29.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:147:0) after 1m0s
[22:22:29.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:147:0)
[22:22:29.663] Timer tick, asking Buildbucket for the build status
[22:22:30.061] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:30.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:148:0) after 1m0s
[22:23:30.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:148:0)
[22:23:30.084] Timer tick, asking Buildbucket for the build status
[22:23:30.210] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:30.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:149:0) after 1m0s
[22:24:30.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:149:0)
[22:24:30.237] Timer tick, asking Buildbucket for the build status
[22:24:30.302] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:30.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:150:0) after 1m0s
[22:25:30.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:150:0)
[22:25:30.351] Timer tick, asking Buildbucket for the build status
[22:25:30.414] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:30.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:151:0) after 1m0s
[22:26:30.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:151:0)
[22:26:30.440] Timer tick, asking Buildbucket for the build status
[22:26:30.484] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:30.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:152:0) after 1m0s
[22:27:30.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:152:0)
[22:27:30.509] Timer tick, asking Buildbucket for the build status
[22:27:30.589] Build 8936013760590438864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:30.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9101443822710493936:153:0) after 1m0s
[22:28:15.315] Received PubSub notification, asking Buildbucket for the build status
[22:28:15.471] Build 8936013760590438864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:28:15.471] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1536359293908567",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1536350207680619",
"id": "8936013760590438864",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8936013760590438864/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3769-3c22b45\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"cb6ec4b1f91af259cbdfd1bd22bb98ed5551955e\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24616}\", \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\swarming\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"got_revision_cp\": \"refs/heads/master@{#589619}\", \"branch\": \"refs/heads/master\", \"revision\": \"26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"7cd2a9514837cfb63f636fa2d213e7941fc76f2e\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"d84b6737fa10f9222c70b44655c382e942c5ffe6\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1536350207680619, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9101443822710493936\", \"scheduler_job_id:chromium/Windows deterministic\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.chromium.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"chromium\", \"id\": \"8936013760590438864\"}}, \"got_v8_revision\": \"98633bd1196c2323aab004d9acbfb08174f94c29\", \"got_v8_revision_cp\": \"refs/heads/7.1.60@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10009, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"705866c4f9cb4486634cda647b74dd342b5d155c\", \"notification_helper_unittests\": \"cc5f8ecaea515223600189fad1fd5fcdd1ce9ce7\", \"gpu_perftests\": \"4b1d70f6a4caf058dfd9befab6bb28f9d90b9b60\", \"vr_common_unittests\": \"2a9400e23890112de2cf06aa6f5f9611b22701b2\", \"telemetry_unittests\": \"0d91e7dff3bf54ac71973509d8cb7760559511ee\", \"load_library_perf_tests\": \"ec1e2136856ad5eecb536533507180a67044ef83\", \"devtools_closure_compile\": \"254a335917b5c9e1e3818f1ce0c5b37c676f0bd5\", \"chromedriver_py_tests\": \"676ac15f0552f01e30de6c347f5adc7c4ab14a9f\", \"mojo_core_unittests\": \"18d6e8982f9a8659405126fe73a75fcb3beaf02a\", \"install_static_unittests\": \"8cb89d9520c783d4d5ecd8fa372544a03dbff7b6\", \"leveldb_service_unittests\": \"5dcafcdd3bef4bb157bb1f51d569676be875db79\", \"mini_installer_tests\": \"8892cc63736a1d170fbb6289548e2af0204d6e48\", \"jingle_unittests\": \"c0b9429dbed382758bd883c93f6c5e49fe921437\", \"sbox_integration_tests\": \"ad762dde558c469df813de7b3e638bfccf1ef5f2\", \"angle_unittests\": \"6cc9b6da1ac7444bb16b7e4cc7e6dcf87fdf39f3\", \"cast_unittests\": \"beadfb5e68d1fb2556fb2f482c2b05c8b8c273cb\", \"cc_unittests\": \"4a9ebbe43e94e98b75050a74f5e2a0fd2876b9b9\", \"blink_common_unittests\": \"19d6591c004632e56ae0e94340b99e5446bef773\", \"crashpad_tests\": \"c4772a26df74cb459e316098a04049b375ed8fcd\", \"telemetry_perf_tests_without_chrome\": \"27c98262819c9a8d4fd41f3e02d567b5e5a67724\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"1dd28ac31763a6ed9acf5cda8df268463cc79f86\", \"ppapi_unittests\": \"c9727e5acea840406639c35db5ec9a60e5689de7\", \"extensions_unittests\": \"4caad20dc9c8233d512290f35f99cb210636283f\", \"gl_unittests_ozone\": \"974410bf5b1a722e9fc113d0f243f49f1cc52b71\", \"app_shell_unittests\": \"e8ff1a3444ac76ef0f9a7ceb987343650205f962\", \"chrome_app_unittests\": \"5ae31052df458b0d9b4781f70f1b0e8346b40d72\", \"gl_unittests\": \"974410bf5b1a722e9fc113d0f243f49f1cc52b71\", \"gcm_unit_tests\": \"41d3f054bc7bd29b2378644cf27647ce7ca53f19\", \"views_unittests\": \"1a70c333527a45acee9eaed093b0bbb9e60b9b2b\", \"content_shell_crash_test\": \"8e096685862e577a569ad178de42b73a3efe5158\", \"ui_base_unittests\": \"35b34ae21440363cb5a867bf825692a84b97acde\", \"gles2_conform_test\": \"2c2924378a9fca31fd5355c226d4e869424914eb\", \"cronet_unittests\": \"b7e93ea2c1ba789854a26ebb2679c41607b5653c\", \"performance_test_suite\": \"373d134978ef9dd7eb347c2c778fb30e5f7c1430\", \"wm_unittests\": \"07671198865d6c7a812b6c4db87cf2890c45f24f\", \"boringssl_crypto_tests\": \"13aaa4eef67c2d42e838bb81ba92099e1b8cb1f4\", \"gin_unittests\": \"ec5fbfc305787a122ca010834e7af4dea05fca9b\", \"performance_browser_tests\": \"3d30e29cd71d956c8ebcae561eac932961adddcc\", \"extensions_browsertests\": \"75e71b0441951fa1bf709c26d8fd90dc65d866c1\", \"webkit_python_tests\": \"54fa6b1c04a11a3b82ce52660d463dbf5a6420c5\", \"headless_unittests\": \"b4c525d712f67e6482fff0a7261fe664a8634bc9\", \"webkit_layout_tests\": \"89746f4893ac33082a2d7f2d0cbb23b5af1ac437\", \"vr_pixeltests\": \"84bee79107aef75a4732c11dd7b1790f159f93e6\", \"setup_unittests\": \"438774e49a573134843d603514388a3d779359ae\", \"webkit_unit_tests\": \"27646f6e271f54eed6a24916d7c06fe17502dd31\", \"content_unittests\": \"61da9444c9a575f86234f0e1b0909c6a92aa31c6\", \"performance_webview_test_suite\": \"b53736e42b53cea7e1799400e729face2a31db8c\", \"wtf_unittests\": \"65f9cc8be6627e6b3d73ce9e87f819155d0761f3\", \"webkit_layout_tests_exparchive\": \"66568620db2174a509016f87cb2c5d197b9c19d7\", \"chrome_cleaner_unittests\": \"166dd339a627422a2e8c8eea9b85861866b2eab2\", \"traffic_annotation_auditor_unittests\": \"3728aa2b094340b589a5756263acf699e3469cc1\", \"libjingle_xmpp_unittests\": \"fbd437c1d66289e93f8e48e44c54510401077653\", \"remoting_unittests\": \"f9a2e44aa64cef14f94f946781b7edcd9919dfd4\", \"vr_common_perftests\": \"acde49536584c9b72f1f319afc30860ac22c3ba9\", \"filesystem_service_unittests\": \"7ecac7a36ea537b401f88b71f00678e6c5c62a61\", \"chrome_elf_import_unittests\": \"2dc60482ee3160e62ef2bc6aa7134ff3f4e9d124\", \"installer_util_unittests\": \"c6ae83ffcb92fabfbbe7aeb45d21863f9776d6a2\", \"gfx_unittests\": \"e002ace7b66ba62334a60f9548105c84e0895600\", \"headless_browsertests\": \"732e7524ed3dc0e5206ebb921da40a22d9ba49fa\", \"capture_unittests\": \"31cfaef32c1a134a0587349c1c311e1c16e8b12e\", \"chrome_elf_unittests\": \"853a6ab9e381b4a62d5c4db870d573952e50a916\", \"telemetry_gpu_unittests\": \"9d2779d196baab662c0d328af9a24084e61fb31a\", \"command_buffer_perftests\": \"18e2a0c8e53509190336dff4e2b2bc05297f0655\", \"media_unittests\": \"f2e146a6833eff680174338975424f7b65b9a12e\", \"chromedriver_unittests\": \"9a70044f20e4bc1bc39d4b10ed31a843ad04e5aa\", \"views_mus_interactive_ui_tests\": \"b92908463757bd97f77a95a57abddce96bffe014\", \"storage_unittests\": \"c0ef71b96fdf2d34a3aa2bab33f38e5f2a42d876\", \"media_service_unittests\": \"a5040faa3f7f32c88756f95fc0f0b025321ddb98\", \"compositor_unittests\": \"e4beec80f6e623ad7f002a2210ae0fd39b09469b\", \"latency_unittests\": \"b919d772224c0020fc03811281ae0928f68193bb\", \"video_decode_accelerator_unittest\": \"6c14f1efab3c838cbb4b08b1a206ccab15eb7d1d\", \"swiftshader_unittests\": \"153dd59cab6fc7c9cd42583fdaff6245002d7998\", \"telemetry_perf_unittests\": \"2feccd6fc41b8c86471e0940c320a57476a14914\", \"media_blink_unittests\": \"3fc7c0e18c726f4c235f0ce7920a3abaaf711319\", \"views_mus_unittests\": \"106c45d18a33225a9acff8c17abfa3f394bf0472\", \"components_unittests\": \"3b3ed61c29c5e72792da5059793d5039d4d6a3af\", \"snapshot_unittests\": \"47d43b88829f6e668d221fb2d628706f4f6e3665\", \"accessibility_unittests\": \"5fd8f2659aefa4f2a11adf11a0d7614618021793\", \"net_perftests\": \"ab63dea22b49f64f8045361da023bcdd0f74c968\", \"aura_unittests\": \"ede1f61932cae98ae0d6c6e322e0880aca759b85\", \"services_unittests\": \"fc7efe20c6ca02a5f11cc60f7b39f300e3e0e747\", \"components_perftests\": \"9468143fe332ad0275e7f21c15a19eeaf44ae6ff\", \"events_unittests\": \"ed6b350ea1564a6fbb41dc4201d540b5046ead13\", \"tracing_perftests\": \"d6838e77e8ed679885127c564aa5ab6919ab2750\", \"chromedriver_replay_unittests\": \"e2ec5b5deadfbf1a0e00246e86e8f3e11e9cace0\", \"ui_touch_selection_unittests\": \"111518cf66d1098f374c2d9e08581623439ff6af\", \"cacheinvalidation_unittests\": \"eb2454fd001266d5190646697055756e9ac5893f\", \"viz_unittests\": \"d7f31e4e3a636f99bebe7edf558f0d2f624a6e5c\", \"browser_tests\": \"0b8bffd7e4f3be1341b6c4d2a286b6435f6d53ca\", \"net_unittests\": \"fb9e227e14acb15eff36029548dc858787137d05\", \"midi_unittests\": \"bb90e47a25a45b064db15ea253add3942f5a9f7b\", \"boringssl_ssl_tests\": \"ea83f5d04662d93f2ae7e3c157d5dc3f86e48b67\", \"sbox_validation_tests\": \"015d6ef2d0425059556ea119301e50ee886b1d55\", \"elevation_service_unittests\": \"7a43f4ca27ac221daffca95a74344ac18b1f3b6c\", \"gpu_unittests\": \"a4720d37d864acc166e9595c6933f52bd472eb0c\", \"native_theme_unittests\": \"ad6fa776b49311f34a56def9e9bf02befea026a1\", \"interactive_ui_tests\": \"9d15a430e0fefb269ae7e3020c1e0a5ce03e2fef\", \"mojo_unittests\": \"b906b50d190b9f993501695cbd71522793fd0cd2\", \"url_unittests\": \"bafba4a97928b1c18602f6c496aca04496dad6ea\", \"media_perftests\": \"bd43b294a88711c4707e3d874d16f4fba6baf267\", \"cronet_tests\": \"04415a54ef7e8ffd52ee7111c92264e4a56aa075\", \"google_apis_unittests\": \"7e5713f251512eb83949d758c68758ee71c89a99\", \"telemetry_gpu_integration_test\": \"cf448e5977ea6ae82f96e5a74e21541a25ead424\", \"blink_heap_unittests\": \"c574469e34b2e73cba3fa335a336bb3ee99238ae\", \"base_unittests\": \"0b76e249bb16f93c68b9a764f16e2f7d2e183a00\", \"sync_integration_tests\": \"13e16fcf35bbd8bb521a4bb0fae7564378358d86\", \"sql_unittests\": \"d8006aebe0586a1f44e4b43033bb88b4cd70680b\", \"courgette_unittests\": \"a6f327d0bd8d587f54711e423b4bdb446eaf821c\", \"blink_fuzzer_unittests\": \"bbe3d1fafd92f0e9deeda768569a51da805134cb\", \"gl_tests\": \"3f076d79c8dba0bce2de1cc1be3350fa25f3ffd5\", \"zucchini_unittests\": \"20debeae1ee5682b49062aa21ddea757a4881ff4\", \"ipc_tests\": \"0cb40773716edb05d4789397233bfbe2ef0cba6e\", \"angle_end2end_tests\": \"10fc5d8c7d7792ff6c4b7741ce69f16d35208d5d\", \"blink_platform_unittests\": \"63c4cc8f7f95c7926867a6bb098e229e88b69fbe\", \"components_browsertests\": \"1ea905d27de1c7762677ddb2f97ed6aebcc8336e\", \"views_perftests\": \"6d816b485320626a1d9d17f2737c55a56f1c0fa1\", \"angle_perftests\": \"72999799cab30e182c848544b1a9626e3ee5dec9\", \"display_unittests\": \"53b27fdf1f9ffd11715fdacca1623d8a60a68504\", \"sbox_unittests\": \"e0be128e5a9086036586dd02f59cd6becb1b89fa\", \"service_manager_unittests\": \"7d6d326cee57728da13f6a43d2a22742da9c43c0\", \"pdf_unittests\": \"469a7a447529766e706c505c1f8cda8d6e49d454\", \"skia_unittests\": \"c483425c2d1862c4cd46350f6fcb82a24eb47e6d\", \"angle_white_box_tests\": \"dd5100d7878b04449ee66388118694f42804850b\", \"crypto_unittests\": \"7619ea45429857866a3522137c632d2fa4fb613c\", \"nacl_loader_unittests\": \"be803f4f5e55e32ed4036e7a321e7115444da12f\", \"unit_tests\": \"1edc1e5c0184d76b282f5e096ecf05271f6694c0\", \"content_browsertests\": \"409c41e216eaf25cecea64c66a795b18d48178ab\", \"printing_unittests\": \"320861efdcdf4ba88c286be2ed483f2cfad3c258\", \"device_unittests\": \"06a8f493cebcbc3010118af92967e5ba06a6c388\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1536350313519638",
"status": "COMPLETED",
"status_changed_ts": "1536359294697655",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10009",
"builder:Windows deterministic",
"buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9101443822710493936",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"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/10009",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8936013760590438864",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:1",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/26fbd76cc1a4da4a46117dfd20e3e1a53c9bd177",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"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/8936013760590438864/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows-10",
"swarming_tag:pool:luci.chromium.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9101443822710493936",
"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:d35ad0202050590393072590ac52b8068d1c49f9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3fce6d529c48e310",
"user_agent:luci-scheduler"
],
"updated_ts": "1536359294699555",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10009",
"utcnow_ts": "1536359295439546"
}
}
[22:28:15.471] Invocation finished in 2h31m29.196461272s with status SUCCEEDED