[10:51:06.081] New invocation is queued and will start shortly
[10:51:07.327] Starting the invocation (attempt 1)
[10:51:07.361] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:51:07.361] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:51:07.361] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097401289818661136",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"32463438c420d2887617acec90ec57b4946b8884\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097401289818661136",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884",
"gitiles_ref:refs/heads/master"
]
}
[10:51:08.972] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540205467450615",
"id": "8931971227721645552",
"lease_expiration_ts": "1540349468605591",
"lease_key": "1363390060",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"32463438c420d2887617acec90ec57b4946b8884\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540205468801247",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10471",
"builder:Windows deterministic",
"buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097401289818661136",
"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/10471",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8931971227721645552",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884",
"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/8931971227721645552/+/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:9097401289818661136",
"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:5d21b61d8922783e1f86e64740632e2a34b9be92",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40b437e25fe67910",
"user_agent:luci-scheduler"
],
"updated_ts": "1540205468801344",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10471",
"utcnow_ts": "1540205468956959"
}
}
[10:51:08.972] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10471
[10:51:08.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:2:0) after 1m0s
[10:52:09.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:2:0)
[10:52:09.010] Timer tick, asking Buildbucket for the build status
[10:52:09.242] Build 8931971227721645552: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:52:09.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:3:0) after 1m0s
[10:52:50.819] Received PubSub notification, asking Buildbucket for the build status
[10:52:50.880] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:09.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:3:0)
[10:53:09.297] Timer tick, asking Buildbucket for the build status
[10:53:09.344] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:09.344] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:5:0) after 1m0s
[10:54:09.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:5:0)
[10:54:09.363] Timer tick, asking Buildbucket for the build status
[10:54:09.421] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:09.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:6:0) after 1m0s
[10:55:09.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:6:0)
[10:55:09.439] Timer tick, asking Buildbucket for the build status
[10:55:09.564] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:09.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:7:0) after 1m0s
[10:56:09.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:7:0)
[10:56:09.584] Timer tick, asking Buildbucket for the build status
[10:56:09.642] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:09.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:8:0) after 1m0s
[10:57:09.662] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:8:0)
[10:57:09.662] Timer tick, asking Buildbucket for the build status
[10:57:09.699] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:09.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:9:0) after 1m0s
[10:58:09.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:9:0)
[10:58:09.719] Timer tick, asking Buildbucket for the build status
[10:58:09.860] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:09.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:10:0) after 1m0s
[10:59:09.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:10:0)
[10:59:09.882] Timer tick, asking Buildbucket for the build status
[10:59:10.112] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:10.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:11:0) after 1m0s
[11:00:10.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:11:0)
[11:00:10.148] Timer tick, asking Buildbucket for the build status
[11:00:10.311] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:12:0) after 1m0s
[11:01:10.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:12:0)
[11:01:10.336] Timer tick, asking Buildbucket for the build status
[11:01:10.397] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:10.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:13:0) after 1m0s
[11:02:10.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:13:0)
[11:02:10.415] Timer tick, asking Buildbucket for the build status
[11:02:10.518] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:10.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:14:0) after 1m0s
[11:03:10.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:14:0)
[11:03:10.538] Timer tick, asking Buildbucket for the build status
[11:03:10.640] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:10.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:15:0) after 1m0s
[11:04:10.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:15:0)
[11:04:10.673] Timer tick, asking Buildbucket for the build status
[11:04:10.860] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:10.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:16:0) after 1m0s
[11:05:10.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:16:0)
[11:05:10.880] Timer tick, asking Buildbucket for the build status
[11:05:10.934] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:10.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:17:0) after 1m0s
[11:06:10.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:17:0)
[11:06:10.953] Timer tick, asking Buildbucket for the build status
[11:06:11.011] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:11.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:18:0) after 1m0s
[11:07:11.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:18:0)
[11:07:11.101] Timer tick, asking Buildbucket for the build status
[11:07:11.198] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:11.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:19:0) after 1m0s
[11:08:11.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:19:0)
[11:08:11.290] Timer tick, asking Buildbucket for the build status
[11:08:11.371] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:11.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:20:0) after 1m0s
[11:09:11.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:20:0)
[11:09:11.408] Timer tick, asking Buildbucket for the build status
[11:09:11.458] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:11.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:21:0) after 1m0s
[11:10:11.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:21:0)
[11:10:11.481] Timer tick, asking Buildbucket for the build status
[11:10:11.657] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:11.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:22:0) after 1m0s
[11:11:11.674] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:22:0)
[11:11:11.674] Timer tick, asking Buildbucket for the build status
[11:11:11.730] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:11.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:23:0) after 1m0s
[11:12:11.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:23:0)
[11:12:11.749] Timer tick, asking Buildbucket for the build status
[11:12:11.816] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:11.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:24:0) after 1m0s
[11:13:11.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:24:0)
[11:13:11.911] Timer tick, asking Buildbucket for the build status
[11:13:11.973] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:11.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:25:0) after 1m0s
[11:14:11.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:25:0)
[11:14:11.993] Timer tick, asking Buildbucket for the build status
[11:14:12.054] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:12.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:26:0) after 1m0s
[11:15:12.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:26:0)
[11:15:12.087] Timer tick, asking Buildbucket for the build status
[11:15:12.208] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:12.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:27:0) after 1m0s
[11:16:12.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:27:0)
[11:16:12.303] Timer tick, asking Buildbucket for the build status
[11:16:12.347] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:12.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:28:0) after 1m0s
[11:17:12.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:28:0)
[11:17:12.399] Timer tick, asking Buildbucket for the build status
[11:17:12.549] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:12.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:29:0) after 1m0s
[11:18:12.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:29:0)
[11:18:12.568] Timer tick, asking Buildbucket for the build status
[11:18:12.672] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:12.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:30:0) after 1m0s
[11:19:12.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:30:0)
[11:19:12.692] Timer tick, asking Buildbucket for the build status
[11:19:12.875] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:12.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:31:0) after 1m0s
[11:20:12.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:31:0)
[11:20:12.900] Timer tick, asking Buildbucket for the build status
[11:20:12.947] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:12.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:32:0) after 1m0s
[11:21:12.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:32:0)
[11:21:12.998] Timer tick, asking Buildbucket for the build status
[11:21:13.046] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:13.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:33:0) after 1m0s
[11:22:13.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:33:0)
[11:22:13.065] Timer tick, asking Buildbucket for the build status
[11:22:13.171] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:13.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:34:0) after 1m0s
[11:23:13.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:34:0)
[11:23:13.191] Timer tick, asking Buildbucket for the build status
[11:23:13.273] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:13.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:35:0) after 1m0s
[11:24:13.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:35:0)
[11:24:13.310] Timer tick, asking Buildbucket for the build status
[11:24:13.515] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:13.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:36:0) after 1m0s
[11:25:13.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:36:0)
[11:25:13.536] Timer tick, asking Buildbucket for the build status
[11:25:13.603] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:13.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:37:0) after 1m0s
[11:26:13.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:37:0)
[11:26:13.647] Timer tick, asking Buildbucket for the build status
[11:26:13.823] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:13.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:38:0) after 1m0s
[11:27:13.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:38:0)
[11:27:13.844] Timer tick, asking Buildbucket for the build status
[11:27:13.897] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:13.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:39:0) after 1m0s
[11:28:13.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:39:0)
[11:28:13.917] Timer tick, asking Buildbucket for the build status
[11:28:13.972] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:13.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:40:0) after 1m0s
[11:29:14.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:40:0)
[11:29:14.015] Timer tick, asking Buildbucket for the build status
[11:29:14.124] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:14.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:41:0) after 1m0s
[11:30:14.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:41:0)
[11:30:14.142] Timer tick, asking Buildbucket for the build status
[11:30:14.257] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:14.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:42:0) after 1m0s
[11:31:14.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:42:0)
[11:31:14.275] Timer tick, asking Buildbucket for the build status
[11:31:14.357] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:14.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:43:0) after 1m0s
[11:32:14.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:43:0)
[11:32:14.384] Timer tick, asking Buildbucket for the build status
[11:32:14.485] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:14.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:44:0) after 1m0s
[11:33:14.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:44:0)
[11:33:14.504] Timer tick, asking Buildbucket for the build status
[11:33:14.552] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:14.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:45:0) after 1m0s
[11:34:14.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:45:0)
[11:34:14.610] Timer tick, asking Buildbucket for the build status
[11:34:14.695] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:14.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:46:0) after 1m0s
[11:35:14.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:46:0)
[11:35:14.715] Timer tick, asking Buildbucket for the build status
[11:35:14.892] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:14.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:47:0) after 1m0s
[11:36:14.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:47:0)
[11:36:14.998] Timer tick, asking Buildbucket for the build status
[11:36:15.076] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:15.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:48:0) after 1m0s
[11:37:15.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:48:0)
[11:37:15.094] Timer tick, asking Buildbucket for the build status
[11:37:15.211] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:15.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:49:0) after 1m0s
[11:38:15.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:49:0)
[11:38:15.245] Timer tick, asking Buildbucket for the build status
[11:38:15.309] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:15.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:50:0) after 1m0s
[11:39:15.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:50:0)
[11:39:15.335] Timer tick, asking Buildbucket for the build status
[11:39:15.425] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:15.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:51:0) after 1m0s
[11:40:15.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:51:0)
[11:40:15.444] Timer tick, asking Buildbucket for the build status
[11:40:15.561] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:15.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:52:0) after 1m0s
[11:41:15.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:52:0)
[11:41:15.595] Timer tick, asking Buildbucket for the build status
[11:41:15.665] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:15.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:53:0) after 1m0s
[11:42:15.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:53:0)
[11:42:15.685] Timer tick, asking Buildbucket for the build status
[11:42:15.731] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:15.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:54:0) after 1m0s
[11:43:15.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:54:0)
[11:43:15.750] Timer tick, asking Buildbucket for the build status
[11:43:15.815] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:15.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:55:0) after 1m0s
[11:44:15.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:55:0)
[11:44:15.842] Timer tick, asking Buildbucket for the build status
[11:44:15.988] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:15.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:56:0) after 1m0s
[11:45:16.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:56:0)
[11:45:16.022] Timer tick, asking Buildbucket for the build status
[11:45:16.080] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:16.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:57:0) after 1m0s
[11:46:16.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:57:0)
[11:46:16.102] Timer tick, asking Buildbucket for the build status
[11:46:16.147] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:16.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:58:0) after 1m0s
[11:47:16.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:58:0)
[11:47:16.217] Timer tick, asking Buildbucket for the build status
[11:47:16.280] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:16.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:59:0) after 1m0s
[11:48:16.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:59:0)
[11:48:16.315] Timer tick, asking Buildbucket for the build status
[11:48:16.353] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:16.353] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:60:0) after 1m0s
[11:49:16.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:60:0)
[11:49:16.375] Timer tick, asking Buildbucket for the build status
[11:49:16.515] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:16.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:61:0) after 1m0s
[11:50:16.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:61:0)
[11:50:16.534] Timer tick, asking Buildbucket for the build status
[11:50:16.608] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:16.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:62:0) after 1m0s
[11:51:16.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:62:0)
[11:51:16.629] Timer tick, asking Buildbucket for the build status
[11:51:16.702] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:16.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:63:0) after 1m0s
[11:52:16.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:63:0)
[11:52:16.724] Timer tick, asking Buildbucket for the build status
[11:52:16.759] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:16.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:64:0) after 1m0s
[11:53:16.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:64:0)
[11:53:16.804] Timer tick, asking Buildbucket for the build status
[11:53:16.896] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:16.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:65:0) after 1m0s
[11:54:16.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:65:0)
[11:54:16.918] Timer tick, asking Buildbucket for the build status
[11:54:16.986] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:16.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:66:0) after 1m0s
[11:55:17.006] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:66:0)
[11:55:17.006] Timer tick, asking Buildbucket for the build status
[11:55:17.060] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:17.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:67:0) after 1m0s
[11:56:17.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:67:0)
[11:56:17.139] Timer tick, asking Buildbucket for the build status
[11:56:17.214] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:17.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:68:0) after 1m0s
[11:57:17.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:68:0)
[11:57:17.237] Timer tick, asking Buildbucket for the build status
[11:57:17.323] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:17.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:69:0) after 1m0s
[11:58:17.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:69:0)
[11:58:17.375] Timer tick, asking Buildbucket for the build status
[11:58:17.512] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:17.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:70:0) after 1m0s
[11:59:17.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:70:0)
[11:59:17.549] Timer tick, asking Buildbucket for the build status
[11:59:17.663] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:17.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:71:0) after 1m0s
[12:00:17.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:71:0)
[12:00:17.684] Timer tick, asking Buildbucket for the build status
[12:00:17.795] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:17.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:72:0) after 1m0s
[12:01:17.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:72:0)
[12:01:17.823] Timer tick, asking Buildbucket for the build status
[12:01:17.874] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:17.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:73:0) after 1m0s
[12:02:17.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:73:0)
[12:02:17.894] Timer tick, asking Buildbucket for the build status
[12:02:17.937] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:17.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:74:0) after 1m0s
[12:03:17.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:74:0)
[12:03:17.958] Timer tick, asking Buildbucket for the build status
[12:03:18.051] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:18.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:75:0) after 1m0s
[12:04:18.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:75:0)
[12:04:18.070] Timer tick, asking Buildbucket for the build status
[12:04:18.253] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:18.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:76:0) after 1m0s
[12:05:18.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:76:0)
[12:05:18.328] Timer tick, asking Buildbucket for the build status
[12:05:18.541] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:18.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:77:0) after 1m0s
[12:06:18.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:77:0)
[12:06:18.594] Timer tick, asking Buildbucket for the build status
[12:06:18.636] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:18.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:78:0) after 1m0s
[12:07:18.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:78:0)
[12:07:18.658] Timer tick, asking Buildbucket for the build status
[12:07:18.778] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:18.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:79:0) after 1m0s
[12:08:18.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:79:0)
[12:08:18.822] Timer tick, asking Buildbucket for the build status
[12:08:19.002] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:19.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:80:0) after 1m0s
[12:09:19.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:80:0)
[12:09:19.040] Timer tick, asking Buildbucket for the build status
[12:09:19.095] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:19.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:81:0) after 1m0s
[12:10:19.119] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:81:0)
[12:10:19.119] Timer tick, asking Buildbucket for the build status
[12:10:19.226] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:19.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:82:0) after 1m0s
[12:11:19.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:82:0)
[12:11:19.249] Timer tick, asking Buildbucket for the build status
[12:11:19.328] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:19.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:83:0) after 1m0s
[12:12:19.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:83:0)
[12:12:19.366] Timer tick, asking Buildbucket for the build status
[12:12:19.452] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:19.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:84:0) after 1m0s
[12:13:19.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:84:0)
[12:13:19.501] Timer tick, asking Buildbucket for the build status
[12:13:19.540] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:19.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:85:0) after 1m0s
[12:14:19.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:85:0)
[12:14:19.568] Timer tick, asking Buildbucket for the build status
[12:14:19.888] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:19.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:86:0) after 1m0s
[12:15:19.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:86:0)
[12:15:19.910] Timer tick, asking Buildbucket for the build status
[12:15:19.970] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:19.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:87:0) after 1m0s
[12:16:19.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:87:0)
[12:16:19.991] Timer tick, asking Buildbucket for the build status
[12:16:20.036] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:20.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:88:0) after 1m0s
[12:17:20.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:88:0)
[12:17:20.056] Timer tick, asking Buildbucket for the build status
[12:17:20.123] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:20.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:89:0) after 1m0s
[12:18:20.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:89:0)
[12:18:20.211] Timer tick, asking Buildbucket for the build status
[12:18:20.298] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:20.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:90:0) after 1m0s
[12:19:20.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:90:0)
[12:19:20.323] Timer tick, asking Buildbucket for the build status
[12:19:20.405] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:20.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:91:0) after 1m0s
[12:20:20.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:91:0)
[12:20:20.430] Timer tick, asking Buildbucket for the build status
[12:20:20.518] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:20.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:92:0) after 1m0s
[12:21:20.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:92:0)
[12:21:20.542] Timer tick, asking Buildbucket for the build status
[12:21:20.727] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:20.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:93:0) after 1m0s
[12:22:20.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:93:0)
[12:22:20.751] Timer tick, asking Buildbucket for the build status
[12:22:20.860] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:20.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:94:0) after 1m0s
[12:23:20.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:94:0)
[12:23:20.903] Timer tick, asking Buildbucket for the build status
[12:23:21.004] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:21.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:95:0) after 1m0s
[12:24:21.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:95:0)
[12:24:21.085] Timer tick, asking Buildbucket for the build status
[12:24:21.190] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:21.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:96:0) after 1m0s
[12:25:21.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:96:0)
[12:25:21.226] Timer tick, asking Buildbucket for the build status
[12:25:21.273] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:21.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:97:0) after 1m0s
[12:26:21.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:97:0)
[12:26:21.378] Timer tick, asking Buildbucket for the build status
[12:26:21.436] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:21.436] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:98:0) after 1m0s
[12:27:21.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:98:0)
[12:27:21.609] Timer tick, asking Buildbucket for the build status
[12:27:21.732] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:21.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:99:0) after 1m0s
[12:28:21.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:99:0)
[12:28:21.759] Timer tick, asking Buildbucket for the build status
[12:28:22.120] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:22.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:100:0) after 1m0s
[12:29:22.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:100:0)
[12:29:22.310] Timer tick, asking Buildbucket for the build status
[12:29:22.404] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:22.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:101:0) after 1m0s
[12:30:22.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:101:0)
[12:30:22.428] Timer tick, asking Buildbucket for the build status
[12:30:22.558] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:22.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:102:0) after 1m0s
[12:31:22.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:102:0)
[12:31:22.616] Timer tick, asking Buildbucket for the build status
[12:31:22.677] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:22.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:103:0) after 1m0s
[12:32:22.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:103:0)
[12:32:22.722] Timer tick, asking Buildbucket for the build status
[12:32:22.763] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:22.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:104:0) after 1m0s
[12:33:22.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:104:0)
[12:33:22.792] Timer tick, asking Buildbucket for the build status
[12:33:23.121] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:23.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:105:0) after 1m0s
[12:34:23.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:105:0)
[12:34:23.165] Timer tick, asking Buildbucket for the build status
[12:34:23.213] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:23.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:106:0) after 1m0s
[12:35:23.236] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:106:0)
[12:35:23.236] Timer tick, asking Buildbucket for the build status
[12:35:23.349] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:107:0) after 1m0s
[12:36:23.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:107:0)
[12:36:23.399] Timer tick, asking Buildbucket for the build status
[12:36:23.468] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:23.468] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:108:0) after 1m0s
[12:37:23.490] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:108:0)
[12:37:23.490] Timer tick, asking Buildbucket for the build status
[12:37:23.658] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:23.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:109:0) after 1m0s
[12:38:23.680] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:109:0)
[12:38:23.680] Timer tick, asking Buildbucket for the build status
[12:38:23.817] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:23.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:110:0) after 1m0s
[12:39:23.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:110:0)
[12:39:23.844] Timer tick, asking Buildbucket for the build status
[12:39:23.891] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:23.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:111:0) after 1m0s
[12:40:23.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:111:0)
[12:40:23.919] Timer tick, asking Buildbucket for the build status
[12:40:23.967] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:23.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:112:0) after 1m0s
[12:41:23.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:112:0)
[12:41:23.990] Timer tick, asking Buildbucket for the build status
[12:41:24.244] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:24.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:113:0) after 1m0s
[12:42:24.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:113:0)
[12:42:24.330] Timer tick, asking Buildbucket for the build status
[12:42:24.375] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:24.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:114:0) after 1m0s
[12:43:24.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:114:0)
[12:43:24.411] Timer tick, asking Buildbucket for the build status
[12:43:24.446] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:24.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:115:0) after 1m0s
[12:44:24.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:115:0)
[12:44:24.470] Timer tick, asking Buildbucket for the build status
[12:44:24.541] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:24.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:116:0) after 1m0s
[12:45:24.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:116:0)
[12:45:24.569] Timer tick, asking Buildbucket for the build status
[12:45:24.694] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:24.694] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:117:0) after 1m0s
[12:46:24.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:117:0)
[12:46:24.718] Timer tick, asking Buildbucket for the build status
[12:46:24.759] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:24.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:118:0) after 1m0s
[12:47:24.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:118:0)
[12:47:24.829] Timer tick, asking Buildbucket for the build status
[12:47:24.894] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:24.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:119:0) after 1m0s
[12:48:24.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:119:0)
[12:48:24.938] Timer tick, asking Buildbucket for the build status
[12:48:24.993] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:24.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:120:0) after 1m0s
[12:49:25.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:120:0)
[12:49:25.123] Timer tick, asking Buildbucket for the build status
[12:49:25.160] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:25.160] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:121:0) after 1m0s
[12:50:25.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:121:0)
[12:50:25.210] Timer tick, asking Buildbucket for the build status
[12:50:25.291] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:25.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:122:0) after 1m0s
[12:51:25.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:122:0)
[12:51:25.321] Timer tick, asking Buildbucket for the build status
[12:51:25.387] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:25.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:123:0) after 1m0s
[12:52:25.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:123:0)
[12:52:25.412] Timer tick, asking Buildbucket for the build status
[12:52:25.485] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:25.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:124:0) after 1m0s
[12:53:25.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:124:0)
[12:53:25.557] Timer tick, asking Buildbucket for the build status
[12:53:25.609] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:25.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:125:0) after 1m0s
[12:54:25.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:125:0)
[12:54:25.642] Timer tick, asking Buildbucket for the build status
[12:54:25.693] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:25.693] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:126:0) after 1m0s
[12:55:25.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:126:0)
[12:55:25.747] Timer tick, asking Buildbucket for the build status
[12:55:25.815] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:25.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:127:0) after 1m0s
[12:56:25.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:127:0)
[12:56:25.839] Timer tick, asking Buildbucket for the build status
[12:56:25.880] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:25.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:128:0) after 1m0s
[12:57:25.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:128:0)
[12:57:25.906] Timer tick, asking Buildbucket for the build status
[12:57:25.963] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:25.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:129:0) after 1m0s
[12:58:25.983] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:129:0)
[12:58:25.983] Timer tick, asking Buildbucket for the build status
[12:58:26.033] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:130:0) after 1m0s
[12:59:26.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:130:0)
[12:59:26.071] Timer tick, asking Buildbucket for the build status
[12:59:26.140] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:26.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:131:0) after 1m0s
[13:00:26.180] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:131:0)
[13:00:26.180] Timer tick, asking Buildbucket for the build status
[13:00:26.251] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:26.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:132:0) after 1m0s
[13:01:26.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:132:0)
[13:01:26.292] Timer tick, asking Buildbucket for the build status
[13:01:26.354] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:26.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:133:0) after 1m0s
[13:02:26.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:133:0)
[13:02:26.416] Timer tick, asking Buildbucket for the build status
[13:02:26.541] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:26.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:134:0) after 1m0s
[13:03:26.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:134:0)
[13:03:26.577] Timer tick, asking Buildbucket for the build status
[13:03:26.632] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:26.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:135:0) after 1m0s
[13:04:26.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:135:0)
[13:04:26.654] Timer tick, asking Buildbucket for the build status
[13:04:26.697] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:26.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:136:0) after 1m0s
[13:05:26.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:136:0)
[13:05:26.729] Timer tick, asking Buildbucket for the build status
[13:05:26.797] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:26.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:137:0) after 1m0s
[13:06:26.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:137:0)
[13:06:26.852] Timer tick, asking Buildbucket for the build status
[13:06:27.116] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:27.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:138:0) after 1m0s
[13:07:27.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:138:0)
[13:07:27.145] Timer tick, asking Buildbucket for the build status
[13:07:27.266] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:27.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:139:0) after 1m0s
[13:08:27.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:139:0)
[13:08:27.295] Timer tick, asking Buildbucket for the build status
[13:08:27.435] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:27.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:140:0) after 1m0s
[13:09:27.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:140:0)
[13:09:27.459] Timer tick, asking Buildbucket for the build status
[13:09:27.606] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:27.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:141:0) after 1m0s
[13:10:27.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:141:0)
[13:10:27.632] Timer tick, asking Buildbucket for the build status
[13:10:27.824] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:27.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:142:0) after 1m0s
[13:11:27.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:142:0)
[13:11:27.858] Timer tick, asking Buildbucket for the build status
[13:11:27.964] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:27.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:143:0) after 1m0s
[13:12:27.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:143:0)
[13:12:27.988] Timer tick, asking Buildbucket for the build status
[13:12:28.060] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:144:0) after 1m0s
[13:13:28.088] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:144:0)
[13:13:28.088] Timer tick, asking Buildbucket for the build status
[13:13:28.158] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:28.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:145:0) after 1m0s
[13:14:28.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:145:0)
[13:14:28.182] Timer tick, asking Buildbucket for the build status
[13:14:28.294] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:28.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:146:0) after 1m0s
[13:15:28.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:146:0)
[13:15:28.349] Timer tick, asking Buildbucket for the build status
[13:15:28.457] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:28.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:147:0) after 1m0s
[13:16:28.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:147:0)
[13:16:28.484] Timer tick, asking Buildbucket for the build status
[13:16:28.658] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:28.658] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:148:0) after 1m0s
[13:17:28.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:148:0)
[13:17:28.691] Timer tick, asking Buildbucket for the build status
[13:17:28.901] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:28.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:149:0) after 1m0s
[13:18:28.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:149:0)
[13:18:28.964] Timer tick, asking Buildbucket for the build status
[13:18:29.065] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:29.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:150:0) after 1m0s
[13:19:29.146] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:150:0)
[13:19:29.146] Timer tick, asking Buildbucket for the build status
[13:19:29.238] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:29.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:151:0) after 1m0s
[13:20:29.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:151:0)
[13:20:29.261] Timer tick, asking Buildbucket for the build status
[13:20:29.309] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:29.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:152:0) after 1m0s
[13:21:29.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:152:0)
[13:21:29.359] Timer tick, asking Buildbucket for the build status
[13:21:29.466] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:29.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:153:0) after 1m0s
[13:22:29.489] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:153:0)
[13:22:29.489] Timer tick, asking Buildbucket for the build status
[13:22:29.557] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:29.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:154:0) after 1m0s
[13:23:29.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:154:0)
[13:23:29.578] Timer tick, asking Buildbucket for the build status
[13:23:29.639] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:29.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:155:0) after 1m0s
[13:24:29.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:155:0)
[13:24:29.689] Timer tick, asking Buildbucket for the build status
[13:24:29.764] Build 8931971227721645552: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:29.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097401289818661136:156:0) after 1m0s
[13:25:22.417] Received PubSub notification, asking Buildbucket for the build status
[13:25:22.504] Build 8931971227721645552: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:25:22.504] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1540214721220185",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540205467450615",
"id": "8931971227721645552",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"32463438c420d2887617acec90ec57b4946b8884\"}}",
"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/8931971227721645552/+/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\": [\"3817-6aedaff\"], \"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\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"32463438c420d2887617acec90ec57b4946b8884\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25280}\", \"$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@{#601520}\", \"branch\": \"refs/heads/master\", \"revision\": \"32463438c420d2887617acec90ec57b4946b8884\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"648d28ad62573c7b1a1e5b05a6122227f7272950\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"7818a85c33d39291248f8f76da78ea13d94c328f\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1540205467450615, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097401289818661136\", \"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\": \"8931971227721645552\"}}, \"got_v8_revision\": \"b248a7f656c85dd83127cdd02ef96f44dafa4477\", \"got_v8_revision_cp\": \"refs/heads/7.2.51@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10471, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"1647441a55083fa0e3f10c2b452c354fd7542df9\", \"notification_helper_unittests\": \"48afe67d60851227aa50215872cab54371429af5\", \"gpu_perftests\": \"981307e69a5f04bb93cda7dd15903d306e2c0183\", \"vr_common_unittests\": \"fd438f043684479048eef16c047f889ecda88a10\", \"telemetry_unittests\": \"5bbe742d1074a1d351440bd6a073a189aec71b66\", \"load_library_perf_tests\": \"5fa029363ad7f713acae3f483e6d9cae1bc13ff4\", \"devtools_closure_compile\": \"e4e56ecf341b99135722ee7f746bdcee8d980454\", \"chromedriver_py_tests\": \"a0b76468095d1c93fd0c95ca89a31033c6c086b6\", \"mojo_core_unittests\": \"e1338db2d7a6dddc20b2de4c3d51946bd1785087\", \"install_static_unittests\": \"fb8cf2fffd288a446416bba69458e6723c61076a\", \"leveldb_service_unittests\": \"16feded5cb78be4dadc9edf9bbb26eadff4fd81b\", \"mini_installer_tests\": \"0ceb4da547ad673d5ad4c459ce7dfe4cc8b2e333\", \"gcp_unittests\": \"1e2964127ec2777329bab2b7e4f1b869bac44cea\", \"sbox_integration_tests\": \"4352b081cb9e26e25356d5a46da4229f28871ed0\", \"angle_unittests\": \"1f98c138e68f2a8ad60ecd65cdd06f72dc5579d2\", \"cast_unittests\": \"bc169171e9310fb9a69532f9587b310b46fbe116\", \"cc_unittests\": \"55b139460b5ebfc6f8313dc57a3c72132b3d0a97\", \"blink_common_unittests\": \"291ed24c116cff9756f4ad38acae26ac3fc8a033\", \"crashpad_tests\": \"b48d405c33703a22d90f248a57e36914ac77bc67\", \"telemetry_perf_tests_without_chrome\": \"3d429d015f985322315b1a9693c4fea6c2413620\", \"metrics_python_tests\": \"a31000cdada7b322bbc3b59093b436676d85f5c1\", \"message_center_unittests\": \"cbb3ef48208a2a2c70fc3b58f297c21ba77f5296\", \"ppapi_unittests\": \"88ceea3df97e18eb20e3a399edb22d44dce57b53\", \"extensions_unittests\": \"afe70b25328b0611321489b8484be2d925acb3de\", \"gl_unittests_ozone\": \"cddfa046023b2acb62c7707e3b3d5b139388c086\", \"app_shell_unittests\": \"0ec452594a487e2a3a64e63abdcff8a0a081b843\", \"chrome_app_unittests\": \"59d7149307c55ce1ef105c8f09e6190f5ef4a0c1\", \"gl_unittests\": \"cddfa046023b2acb62c7707e3b3d5b139388c086\", \"gcm_unit_tests\": \"dd8ffac9665d4c9868205fa20583a4138bfba3b1\", \"views_unittests\": \"52859be0c7228122ce0effbb10d1cc21e038a68b\", \"content_shell_crash_test\": \"af19ff250e8b1a90592eacfa1a6abc354623fa48\", \"ui_base_unittests\": \"59e2c55d561ddb1f5f870a23c9ee9c4bb242485a\", \"cronet_unittests\": \"af6e367876dd5047a3ec2e8fb8e0affe958b38bb\", \"performance_test_suite\": \"f4c7a49709cbf11f3d4936d2c1f2aea003526b92\", \"wm_unittests\": \"d5ed0dc23c09308c3197223365b7bbd212d2a094\", \"boringssl_crypto_tests\": \"73d10ab97012a349a02c03a00f8ff1207e6901e9\", \"gin_unittests\": \"6840c7e006d246aebb37c7e91fb9aaf3a57a264f\", \"performance_browser_tests\": \"8278ea95896306bb8ce62073549e59dbdbd7fb76\", \"extensions_browsertests\": \"bbc4a23b0e0fa60e4262c25232867e110a1b2fe3\", \"webkit_python_tests\": \"b940ed7624988b815450f468b04efc01bb7f851e\", \"headless_unittests\": \"8418126dce84655e3dc712ecde69c65f988d2ea1\", \"webkit_layout_tests\": \"f82f9fbf87d1a5bbe639541346be331821006fad\", \"vr_pixeltests\": \"fa0628b032bd3deda0ca1fee860da5b3a2908728\", \"setup_unittests\": \"a096cff95c010db22a46a65fdcc14a12c1898f09\", \"webkit_unit_tests\": \"25f726ad9c123b6f12086febb70c5a883821e833\", \"content_unittests\": \"fb967a56ca47ec29b7c3293ebd5f62ee8b602c73\", \"performance_webview_test_suite\": \"0620e959ea4d317a92a0968e880af0e047b659d5\", \"wtf_unittests\": \"b62af613281b2756900017cac492a0c4e054d138\", \"webkit_layout_tests_exparchive\": \"c3efa66b7397518ce72c8c7079ee7e5579df7ecc\", \"chrome_cleaner_unittests\": \"34ea41a013b6926ff023b0d04789d6f14ea0e3e9\", \"traffic_annotation_auditor_unittests\": \"1225c5fb3a06b95caacdfa9b75b98ced424338d1\", \"libjingle_xmpp_unittests\": \"227c8c9714e988d31e8d4f3660f6c43b5bb94e52\", \"remoting_unittests\": \"346a3fed05cc6efe468df38c846feb52f2f449f8\", \"vr_common_perftests\": \"5060d9a2852eb43ede1d7e9bc60998244a59dbfd\", \"filesystem_service_unittests\": \"18083d302c8e24fb8b26958b5e1744c151f2e6b2\", \"chrome_elf_import_unittests\": \"7d63cad7aaf815fbdff9da869bd0796de7cafb95\", \"installer_util_unittests\": \"68764fe35b06e82c5b97319920a894d4830f9ae1\", \"gfx_unittests\": \"306736d61cb3fe34d912924d4fb65ab2ab400cea\", \"headless_browsertests\": \"49c90cf4ced57d948b2f1db389cf615b5e30b56a\", \"capture_unittests\": \"60a45716199e2a502f982e273f41cd48f6434a7e\", \"chrome_elf_unittests\": \"1736a565a63e3360dfbdb7e43191abe124e68dfe\", \"telemetry_gpu_unittests\": \"ef9b0e4b4b5f7b7455156d75303994a15cdf1fce\", \"command_buffer_perftests\": \"044062f8cd8b24dde56c60b8f7a4f54c1786e906\", \"media_unittests\": \"2ac7a20ecb987ad178a7c07876e1016510d88016\", \"chromedriver_unittests\": \"be91b0242a49312940a3a2cecd3e9f057c3da2da\", \"views_mus_interactive_ui_tests\": \"73e3babf0630e12d59eb941e105b16d49c345dd9\", \"storage_unittests\": \"b1056516add56103585244fd8caabf177040d47f\", \"media_service_unittests\": \"cdec11b46d6faefb899138659e488977f699b378\", \"compositor_unittests\": \"a7e702c31b50eb7b1e44ae532631ca691164ce78\", \"latency_unittests\": \"b4ca4b659ef65251a4561b19a2eadf8b7c547267\", \"video_decode_accelerator_unittest\": \"4f861e4e797b7f8d3158cdec113e02f5ebdb825d\", \"swiftshader_unittests\": \"de819118fae0a15aca56897b4f5e69a608ecba6d\", \"telemetry_perf_unittests\": \"842c4148c4f6e1d52af8f3f4b6fe38df3fc8a07d\", \"media_blink_unittests\": \"aa508935fed1b872a6f7c9a8983dc4aff50ad81b\", \"views_mus_unittests\": \"2aa4d8a984debb617e5b861bf7afb671605f3a7e\", \"components_unittests\": \"30e694c3c4d350aac9335ec710495ded919164ee\", \"snapshot_unittests\": \"c84838ffc0c9d993a4e9d58ba644492bfdb03886\", \"accessibility_unittests\": \"a61bcfd447b67a48f5575d7e31e2d27f8a0965f1\", \"net_perftests\": \"b334899debbd75d299d1049e557ffac7baccd6a0\", \"aura_unittests\": \"ea02270f941ef1831bf297f58bbc94b86c7582d3\", \"services_unittests\": \"1214a5bf5c1be9a627473f107d544e06c6b9ec5d\", \"components_perftests\": \"61c178f83f3b0794fc23028ed397fa1ba69d56e4\", \"events_unittests\": \"a4d71dc8db1b14611af056e4da2dfd0b45364176\", \"tracing_perftests\": \"2d0fd59ea342b633cbe6647ae4dfd8f854bfc151\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"40ba6b7a5eaf57f9d64c3c8bc097f4d7ac156f2e\", \"cacheinvalidation_unittests\": \"ed150e53d4a9e6248160c4901880f2269bb2689b\", \"viz_unittests\": \"eb8062ac34b2cc3372cc96fccf7c370ff11ad5d6\", \"browser_tests\": \"9445865a017a64e25d02c1866a5fa6c7decc5bb6\", \"net_unittests\": \"41ad3188a9f6289ca444a981507534faeca2da4d\", \"pdf_unittests\": \"870a29a5db472401d9ad10b401ecd8ce3dc7f16a\", \"boringssl_ssl_tests\": \"d167046115bbf35e2c6e720df25b4ab52a1c8346\", \"sbox_validation_tests\": \"bf887b4972c8843bab290c1ee52c6d3f91dd0763\", \"elevation_service_unittests\": \"1acb7290b035fb8bd636590430ed6c91c96177b5\", \"gpu_unittests\": \"4db66c5dacaf9313b90181387480a6821b6036b1\", \"native_theme_unittests\": \"8bed3be66f858236af030b70a392d3f0e0ce002c\", \"interactive_ui_tests\": \"21d402fbff3725d12b28450ef1f35c57161c5b28\", \"mojo_unittests\": \"e915c9c81b3f524bc04a406b7a5c3fa6e66e3a97\", \"url_unittests\": \"e4ffc7030b97bb148c4a67782ed07130c1630aac\", \"media_perftests\": \"5702822ed60294d263ede1dac190b0ceac372ed9\", \"cronet_tests\": \"31426cb4e1cc81276c59d075e614f4aba108a15f\", \"google_apis_unittests\": \"a3d2b8b1e9552e14a41c38df57fa202912d4beb1\", \"telemetry_gpu_integration_test\": \"8e959083fdfc9903561494732b20ec83b049cba2\", \"blink_heap_unittests\": \"56e335987bd01044e466e0e4059e905a0db43e6d\", \"midi_unittests\": \"8deaa8357fafafac3c1e1e4166f07d02cb491785\", \"base_unittests\": \"81955536f69af4fd96dfe0da01e492eecb806109\", \"sync_integration_tests\": \"1b79696e581108c9ea423fa417f9d20ad18607b9\", \"sql_unittests\": \"8db2c7f1e46cf4db46bd91499134b3b5a0d44f49\", \"courgette_unittests\": \"0f5f054b85fdc80a730d9cc29884399d05587b03\", \"blink_fuzzer_unittests\": \"2ea935def87004809de302aafd898767fe140f5f\", \"gl_tests\": \"20b1d642e972b9dba7061aa0e42ac7dbe49e59f3\", \"zucchini_unittests\": \"27d1ec0ac60b1c99a6dde13f307317ed295304c1\", \"ipc_tests\": \"a55911601b34d3caa77f11220ff3143d5fc1074e\", \"angle_end2end_tests\": \"655a5a53163d7e062ba7086bab11a8de4992c02b\", \"blink_platform_unittests\": \"fb37fcd5a35f89e96124060410d3e8bf90625126\", \"components_browsertests\": \"ee5dedfca5839bf60ef041ad580c8ec63a4f65f1\", \"views_perftests\": \"c512720286ba0903410367c6b444958aa0d74e0b\", \"angle_perftests\": \"071a96f009b220b9fcb7c6185d5ad1e83ddd86cf\", \"display_unittests\": \"be907c1e2082b9acebf43eb51fbb26fb7fe23fe6\", \"sbox_unittests\": \"f2bc134fade0d41f05451385096058964eadba74\", \"service_manager_unittests\": \"524783e08c5f16b86b4322b6bec5d61e1709c973\", \"gles2_conform_test\": \"5159734668f887b1d834946a2a794b1e2f0910e2\", \"jingle_unittests\": \"82a403e4f98b1057619babf5139b293ca998c32d\", \"skia_unittests\": \"5fa9814c18bf579a47787d426e081c4c7345f4ca\", \"angle_white_box_tests\": \"752b2e55e59829d4276404c044ce0239f7cdeff6\", \"crypto_unittests\": \"745b605ba1fd4fa2f75876147ecd7f2d92c67dfd\", \"nacl_loader_unittests\": \"05a80cee68c25d98f3d2dfd65816689d29d03d63\", \"unit_tests\": \"7d891835418f2d82fac2423fac5870a885744131\", \"content_browsertests\": \"cc0604eed419eb4225ec9a161e8a9e8b954089ad\", \"printing_unittests\": \"3af27c2ab18ed4ade360e80471c5550669cad035\", \"device_unittests\": \"5cb97892da2751f530e0a93ba43cb737e4637b6c\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540205567811576",
"status": "COMPLETED",
"status_changed_ts": "1540214721830048",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10471",
"builder:Windows deterministic",
"buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097401289818661136",
"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/10471",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8931971227721645552",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/32463438c420d2887617acec90ec57b4946b8884",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/32463438c420d2887617acec90ec57b4946b8884",
"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/8931971227721645552/+/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:9097401289818661136",
"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:5d21b61d8922783e1f86e64740632e2a34b9be92",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40b437e25fe67910",
"user_agent:luci-scheduler"
],
"updated_ts": "1540214721832226",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10471",
"utcnow_ts": "1540214722470108"
}
}
[13:25:22.504] Invocation finished in 2h34m16.437759436s with status SUCCEEDED