[16:28:43.216] New invocation is queued and will start shortly
[16:28:44.470] Starting the invocation (attempt 1)
[16:28:44.517] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:28:44.518] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:28:44.518] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9100369748565797168",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b18f54c0b3661dff00bbe578c75340c71c10770f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9100369748565797168",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f",
"gitiles_ref:refs/heads/master"
]
}
[16:28:45.672] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537374524642329",
"id": "8934939686407065840",
"lease_expiration_ts": "1537518525479953",
"lease_key": "1028079776",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b18f54c0b3661dff00bbe578c75340c71c10770f\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1537374525574668",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10138",
"builder:Windows deterministic",
"buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9100369748565797168",
"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/10138",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934939686407065840",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f",
"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/8934939686407065840/+/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:9100369748565797168",
"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:731a34751ed7c0e7d53ce68735dc569104507fe4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:400b7b1f5d953a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1537374525574773",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10138",
"utcnow_ts": "1537374525660751"
}
}
[16:28:45.672] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10138
[16:28:45.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:2:0) after 1m0s
[16:28:51.539] Received PubSub notification, asking Buildbucket for the build status
[16:28:51.581] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:45.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:2:0)
[16:29:45.692] Timer tick, asking Buildbucket for the build status
[16:29:45.735] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:45.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:4:0) after 1m0s
[16:30:45.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:4:0)
[16:30:45.752] Timer tick, asking Buildbucket for the build status
[16:30:45.794] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:45.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:5:0) after 1m0s
[16:31:45.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:5:0)
[16:31:45.873] Timer tick, asking Buildbucket for the build status
[16:31:45.947] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:45.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:6:0) after 1m0s
[16:32:45.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:6:0)
[16:32:45.972] Timer tick, asking Buildbucket for the build status
[16:32:46.130] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:46.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:7:0) after 1m0s
[16:33:46.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:7:0)
[16:33:46.148] Timer tick, asking Buildbucket for the build status
[16:33:46.203] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:46.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:8:0) after 1m0s
[16:34:46.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:8:0)
[16:34:46.251] Timer tick, asking Buildbucket for the build status
[16:34:46.315] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:46.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:9:0) after 1m0s
[16:35:46.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:9:0)
[16:35:46.339] Timer tick, asking Buildbucket for the build status
[16:35:46.400] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:46.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:10:0) after 1m0s
[16:36:46.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:10:0)
[16:36:46.443] Timer tick, asking Buildbucket for the build status
[16:36:46.485] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:46.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:11:0) after 1m0s
[16:37:46.504] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:11:0)
[16:37:46.504] Timer tick, asking Buildbucket for the build status
[16:37:46.564] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:46.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:12:0) after 1m0s
[16:38:46.589] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:12:0)
[16:38:46.589] Timer tick, asking Buildbucket for the build status
[16:38:46.630] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:46.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:13:0) after 1m0s
[16:39:46.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:13:0)
[16:39:46.651] Timer tick, asking Buildbucket for the build status
[16:39:46.734] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:46.734] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:14:0) after 1m0s
[16:40:46.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:14:0)
[16:40:46.757] Timer tick, asking Buildbucket for the build status
[16:40:46.853] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:46.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:15:0) after 1m0s
[16:41:46.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:15:0)
[16:41:46.874] Timer tick, asking Buildbucket for the build status
[16:41:47.100] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:47.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:16:0) after 1m0s
[16:42:47.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:16:0)
[16:42:47.122] Timer tick, asking Buildbucket for the build status
[16:42:47.169] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:47.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:17:0) after 1m0s
[16:43:47.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:17:0)
[16:43:47.273] Timer tick, asking Buildbucket for the build status
[16:43:47.356] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:47.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:18:0) after 1m0s
[16:44:47.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:18:0)
[16:44:47.383] Timer tick, asking Buildbucket for the build status
[16:44:47.437] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:47.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:19:0) after 1m0s
[16:45:47.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:19:0)
[16:45:47.455] Timer tick, asking Buildbucket for the build status
[16:45:47.524] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:47.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:20:0) after 1m0s
[16:46:47.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:20:0)
[16:46:47.552] Timer tick, asking Buildbucket for the build status
[16:46:47.601] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:47.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:21:0) after 1m0s
[16:47:47.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:21:0)
[16:47:47.623] Timer tick, asking Buildbucket for the build status
[16:47:47.702] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:47.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:22:0) after 1m0s
[16:48:47.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:22:0)
[16:48:47.775] Timer tick, asking Buildbucket for the build status
[16:48:47.853] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:47.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:23:0) after 1m0s
[16:49:47.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:23:0)
[16:49:47.946] Timer tick, asking Buildbucket for the build status
[16:49:47.993] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:47.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:24:0) after 1m0s
[16:50:48.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:24:0)
[16:50:48.034] Timer tick, asking Buildbucket for the build status
[16:50:48.172] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:48.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:25:0) after 1m0s
[16:51:48.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:25:0)
[16:51:48.191] Timer tick, asking Buildbucket for the build status
[16:51:48.294] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:48.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:26:0) after 1m0s
[16:52:48.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:26:0)
[16:52:48.315] Timer tick, asking Buildbucket for the build status
[16:52:48.357] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:48.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:27:0) after 1m0s
[16:53:48.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:27:0)
[16:53:48.405] Timer tick, asking Buildbucket for the build status
[16:53:48.589] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:48.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:28:0) after 1m0s
[16:54:48.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:28:0)
[16:54:48.607] Timer tick, asking Buildbucket for the build status
[16:54:48.653] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:48.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:29:0) after 1m0s
[16:55:48.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:29:0)
[16:55:48.672] Timer tick, asking Buildbucket for the build status
[16:55:48.753] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:48.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:30:0) after 1m0s
[16:56:48.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:30:0)
[16:56:48.792] Timer tick, asking Buildbucket for the build status
[16:56:48.944] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:31:0) after 1m0s
[16:57:48.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:31:0)
[16:57:48.984] Timer tick, asking Buildbucket for the build status
[16:57:49.092] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:49.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:32:0) after 1m0s
[16:58:49.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:32:0)
[16:58:49.116] Timer tick, asking Buildbucket for the build status
[16:58:49.181] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:49.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:33:0) after 1m0s
[16:59:49.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:33:0)
[16:59:49.206] Timer tick, asking Buildbucket for the build status
[16:59:49.253] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:49.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:34:0) after 1m0s
[17:00:49.272] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:34:0)
[17:00:49.272] Timer tick, asking Buildbucket for the build status
[17:00:49.317] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:49.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:35:0) after 1m0s
[17:01:49.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:35:0)
[17:01:49.344] Timer tick, asking Buildbucket for the build status
[17:01:49.465] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:49.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:36:0) after 1m0s
[17:02:49.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:36:0)
[17:02:49.511] Timer tick, asking Buildbucket for the build status
[17:02:49.568] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:49.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:37:0) after 1m0s
[17:03:49.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:37:0)
[17:03:49.593] Timer tick, asking Buildbucket for the build status
[17:03:49.679] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:49.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:38:0) after 1m0s
[17:04:49.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:38:0)
[17:04:49.704] Timer tick, asking Buildbucket for the build status
[17:04:49.749] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:49.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:39:0) after 1m0s
[17:05:49.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:39:0)
[17:05:49.769] Timer tick, asking Buildbucket for the build status
[17:05:49.840] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:49.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:40:0) after 1m0s
[17:06:49.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:40:0)
[17:06:49.864] Timer tick, asking Buildbucket for the build status
[17:06:49.903] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:49.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:41:0) after 1m0s
[17:07:49.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:41:0)
[17:07:49.955] Timer tick, asking Buildbucket for the build status
[17:07:50.048] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:50.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:42:0) after 1m0s
[17:08:50.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:42:0)
[17:08:50.068] Timer tick, asking Buildbucket for the build status
[17:08:50.110] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:50.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:43:0) after 1m0s
[17:09:50.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:43:0)
[17:09:50.135] Timer tick, asking Buildbucket for the build status
[17:09:50.238] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:50.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:44:0) after 1m0s
[17:10:50.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:44:0)
[17:10:50.289] Timer tick, asking Buildbucket for the build status
[17:10:50.387] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:50.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:45:0) after 1m0s
[17:11:50.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:45:0)
[17:11:50.407] Timer tick, asking Buildbucket for the build status
[17:11:50.482] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:50.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:46:0) after 1m0s
[17:12:50.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:46:0)
[17:12:50.503] Timer tick, asking Buildbucket for the build status
[17:12:50.618] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:50.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:47:0) after 1m0s
[17:13:50.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:47:0)
[17:13:50.747] Timer tick, asking Buildbucket for the build status
[17:13:50.933] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:50.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:48:0) after 1m0s
[17:14:50.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:48:0)
[17:14:50.956] Timer tick, asking Buildbucket for the build status
[17:14:51.129] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:51.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:49:0) after 1m0s
[17:15:51.161] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:49:0)
[17:15:51.161] Timer tick, asking Buildbucket for the build status
[17:15:51.377] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:51.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:50:0) after 1m0s
[17:16:51.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:50:0)
[17:16:51.399] Timer tick, asking Buildbucket for the build status
[17:16:51.562] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:51.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:51:0) after 1m0s
[17:17:51.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:51:0)
[17:17:51.592] Timer tick, asking Buildbucket for the build status
[17:17:51.837] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:51.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:52:0) after 1m0s
[17:18:51.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:52:0)
[17:18:51.868] Timer tick, asking Buildbucket for the build status
[17:18:51.952] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:51.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:53:0) after 1m0s
[17:19:51.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:53:0)
[17:19:51.978] Timer tick, asking Buildbucket for the build status
[17:19:52.022] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:54:0) after 1m0s
[17:20:52.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:54:0)
[17:20:52.043] Timer tick, asking Buildbucket for the build status
[17:20:52.112] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:52.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:55:0) after 1m0s
[17:21:52.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:55:0)
[17:21:52.233] Timer tick, asking Buildbucket for the build status
[17:21:52.301] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:52.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:56:0) after 1m0s
[17:22:52.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:56:0)
[17:22:52.335] Timer tick, asking Buildbucket for the build status
[17:22:52.372] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:52.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:57:0) after 1m0s
[17:23:52.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:57:0)
[17:23:52.402] Timer tick, asking Buildbucket for the build status
[17:23:52.438] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:52.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:58:0) after 1m0s
[17:24:52.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:58:0)
[17:24:52.465] Timer tick, asking Buildbucket for the build status
[17:24:52.626] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:52.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:59:0) after 1m0s
[17:25:52.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:59:0)
[17:25:52.651] Timer tick, asking Buildbucket for the build status
[17:25:52.705] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:52.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:60:0) after 1m0s
[17:26:52.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:60:0)
[17:26:52.727] Timer tick, asking Buildbucket for the build status
[17:26:52.764] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:52.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:61:0) after 1m0s
[17:27:52.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:61:0)
[17:27:52.874] Timer tick, asking Buildbucket for the build status
[17:27:52.912] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:52.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:62:0) after 1m0s
[17:28:52.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:62:0)
[17:28:52.949] Timer tick, asking Buildbucket for the build status
[17:28:53.024] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:53.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:63:0) after 1m0s
[17:29:53.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:63:0)
[17:29:53.048] Timer tick, asking Buildbucket for the build status
[17:29:53.106] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:53.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:64:0) after 1m0s
[17:30:53.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:64:0)
[17:30:53.174] Timer tick, asking Buildbucket for the build status
[17:30:53.241] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:53.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:65:0) after 1m0s
[17:31:53.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:65:0)
[17:31:53.261] Timer tick, asking Buildbucket for the build status
[17:31:53.309] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:53.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:66:0) after 1m0s
[17:32:53.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:66:0)
[17:32:53.331] Timer tick, asking Buildbucket for the build status
[17:32:53.367] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:53.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:67:0) after 1m0s
[17:33:53.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:67:0)
[17:33:53.396] Timer tick, asking Buildbucket for the build status
[17:33:53.490] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:53.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:68:0) after 1m0s
[17:34:53.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:68:0)
[17:34:53.530] Timer tick, asking Buildbucket for the build status
[17:34:53.620] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:53.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:69:0) after 1m0s
[17:35:53.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:69:0)
[17:35:53.643] Timer tick, asking Buildbucket for the build status
[17:35:53.680] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:70:0) after 1m0s
[17:36:53.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:70:0)
[17:36:53.703] Timer tick, asking Buildbucket for the build status
[17:36:54.000] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:54.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:71:0) after 1m0s
[17:37:54.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:71:0)
[17:37:54.038] Timer tick, asking Buildbucket for the build status
[17:37:54.130] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:54.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:72:0) after 1m0s
[17:38:54.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:72:0)
[17:38:54.175] Timer tick, asking Buildbucket for the build status
[17:38:54.302] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:54.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:73:0) after 1m0s
[17:39:54.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:73:0)
[17:39:54.387] Timer tick, asking Buildbucket for the build status
[17:39:54.435] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:54.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:74:0) after 1m0s
[17:40:54.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:74:0)
[17:40:54.455] Timer tick, asking Buildbucket for the build status
[17:40:54.591] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:54.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:75:0) after 1m0s
[17:41:54.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:75:0)
[17:41:54.668] Timer tick, asking Buildbucket for the build status
[17:41:54.765] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:54.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:76:0) after 1m0s
[17:42:54.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:76:0)
[17:42:54.796] Timer tick, asking Buildbucket for the build status
[17:42:54.913] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:54.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:77:0) after 1m0s
[17:43:54.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:77:0)
[17:43:54.940] Timer tick, asking Buildbucket for the build status
[17:43:54.975] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:54.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:78:0) after 1m0s
[17:44:55.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:78:0)
[17:44:55.003] Timer tick, asking Buildbucket for the build status
[17:44:55.278] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:55.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:79:0) after 1m0s
[17:45:55.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:79:0)
[17:45:55.300] Timer tick, asking Buildbucket for the build status
[17:45:55.338] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:55.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:80:0) after 1m0s
[17:46:55.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:80:0)
[17:46:55.363] Timer tick, asking Buildbucket for the build status
[17:46:55.423] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:55.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:81:0) after 1m0s
[17:47:55.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:81:0)
[17:47:55.448] Timer tick, asking Buildbucket for the build status
[17:47:55.506] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:55.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:82:0) after 1m0s
[17:48:55.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:82:0)
[17:48:55.533] Timer tick, asking Buildbucket for the build status
[17:48:55.606] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:55.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:83:0) after 1m0s
[17:49:55.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:83:0)
[17:49:55.631] Timer tick, asking Buildbucket for the build status
[17:49:55.707] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:55.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:84:0) after 1m0s
[17:50:55.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:84:0)
[17:50:55.792] Timer tick, asking Buildbucket for the build status
[17:50:55.848] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:55.848] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:85:0) after 1m0s
[17:51:55.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:85:0)
[17:51:55.876] Timer tick, asking Buildbucket for the build status
[17:51:55.919] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:55.919] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:86:0) after 1m0s
[17:52:55.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:86:0)
[17:52:55.949] Timer tick, asking Buildbucket for the build status
[17:52:56.143] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:56.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:87:0) after 1m0s
[17:53:56.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:87:0)
[17:53:56.171] Timer tick, asking Buildbucket for the build status
[17:53:56.206] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:56.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:88:0) after 1m0s
[17:54:56.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:88:0)
[17:54:56.226] Timer tick, asking Buildbucket for the build status
[17:54:56.283] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:56.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:89:0) after 1m0s
[17:55:56.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:89:0)
[17:55:56.303] Timer tick, asking Buildbucket for the build status
[17:55:56.335] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:56.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:90:0) after 1m0s
[17:56:56.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:90:0)
[17:56:56.409] Timer tick, asking Buildbucket for the build status
[17:56:56.514] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:56.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:91:0) after 1m0s
[17:57:56.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:91:0)
[17:57:56.540] Timer tick, asking Buildbucket for the build status
[17:57:56.579] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:56.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:92:0) after 1m0s
[17:58:56.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:92:0)
[17:58:56.603] Timer tick, asking Buildbucket for the build status
[17:58:56.671] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:56.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:93:0) after 1m0s
[17:59:56.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:93:0)
[17:59:56.790] Timer tick, asking Buildbucket for the build status
[17:59:56.964] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:56.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:94:0) after 1m0s
[18:00:56.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:94:0)
[18:00:56.993] Timer tick, asking Buildbucket for the build status
[18:00:57.035] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:57.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:95:0) after 1m0s
[18:01:57.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:95:0)
[18:01:57.067] Timer tick, asking Buildbucket for the build status
[18:01:57.150] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:57.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:96:0) after 1m0s
[18:02:57.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:96:0)
[18:02:57.171] Timer tick, asking Buildbucket for the build status
[18:02:57.218] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:57.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:97:0) after 1m0s
[18:03:57.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:97:0)
[18:03:57.313] Timer tick, asking Buildbucket for the build status
[18:03:57.359] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:57.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:98:0) after 1m0s
[18:04:57.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:98:0)
[18:04:57.394] Timer tick, asking Buildbucket for the build status
[18:04:57.474] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:57.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:99:0) after 1m0s
[18:05:57.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:99:0)
[18:05:57.548] Timer tick, asking Buildbucket for the build status
[18:05:57.591] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:57.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:100:0) after 1m0s
[18:06:57.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:100:0)
[18:06:57.615] Timer tick, asking Buildbucket for the build status
[18:06:57.972] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:57.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:101:0) after 1m0s
[18:07:57.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:101:0)
[18:07:57.996] Timer tick, asking Buildbucket for the build status
[18:07:58.085] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:58.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:102:0) after 1m0s
[18:08:58.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:102:0)
[18:08:58.245] Timer tick, asking Buildbucket for the build status
[18:08:58.337] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:58.337] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:103:0) after 1m0s
[18:09:58.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:103:0)
[18:09:58.363] Timer tick, asking Buildbucket for the build status
[18:09:58.432] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:58.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:104:0) after 1m0s
[18:10:58.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:104:0)
[18:10:58.457] Timer tick, asking Buildbucket for the build status
[18:10:58.522] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:58.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:105:0) after 1m0s
[18:11:58.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:105:0)
[18:11:58.546] Timer tick, asking Buildbucket for the build status
[18:11:58.640] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:58.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:106:0) after 1m0s
[18:12:58.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:106:0)
[18:12:58.666] Timer tick, asking Buildbucket for the build status
[18:12:59.096] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:59.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:107:0) after 1m0s
[18:13:59.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:107:0)
[18:13:59.152] Timer tick, asking Buildbucket for the build status
[18:13:59.262] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:59.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:108:0) after 1m0s
[18:14:59.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:108:0)
[18:14:59.284] Timer tick, asking Buildbucket for the build status
[18:14:59.354] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:59.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:109:0) after 1m0s
[18:15:59.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:109:0)
[18:15:59.404] Timer tick, asking Buildbucket for the build status
[18:15:59.444] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:59.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:110:0) after 1m0s
[18:16:59.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:110:0)
[18:16:59.507] Timer tick, asking Buildbucket for the build status
[18:16:59.596] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:59.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:111:0) after 1m0s
[18:17:59.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:111:0)
[18:17:59.698] Timer tick, asking Buildbucket for the build status
[18:17:59.735] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:59.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:112:0) after 1m0s
[18:18:59.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:112:0)
[18:18:59.759] Timer tick, asking Buildbucket for the build status
[18:18:59.798] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:59.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:113:0) after 1m0s
[18:19:59.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:113:0)
[18:19:59.823] Timer tick, asking Buildbucket for the build status
[18:19:59.879] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:59.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:114:0) after 1m0s
[18:20:59.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:114:0)
[18:20:59.904] Timer tick, asking Buildbucket for the build status
[18:20:59.954] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:59.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:115:0) after 1m0s
[18:21:59.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:115:0)
[18:21:59.975] Timer tick, asking Buildbucket for the build status
[18:22:00.047] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:00.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:116:0) after 1m0s
[18:23:00.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:116:0)
[18:23:00.070] Timer tick, asking Buildbucket for the build status
[18:23:00.179] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:00.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:117:0) after 1m0s
[18:24:00.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:117:0)
[18:24:00.344] Timer tick, asking Buildbucket for the build status
[18:24:00.600] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:00.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:118:0) after 1m0s
[18:25:00.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:118:0)
[18:25:00.628] Timer tick, asking Buildbucket for the build status
[18:25:00.757] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:00.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:119:0) after 1m0s
[18:26:00.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:119:0)
[18:26:00.893] Timer tick, asking Buildbucket for the build status
[18:26:00.944] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:00.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:120:0) after 1m0s
[18:27:00.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:120:0)
[18:27:00.975] Timer tick, asking Buildbucket for the build status
[18:27:01.116] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:01.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:121:0) after 1m0s
[18:28:01.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:121:0)
[18:28:01.156] Timer tick, asking Buildbucket for the build status
[18:28:01.186] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:01.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:122:0) after 1m0s
[18:29:01.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:122:0)
[18:29:01.241] Timer tick, asking Buildbucket for the build status
[18:29:01.333] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:01.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:123:0) after 1m0s
[18:30:01.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:123:0)
[18:30:01.406] Timer tick, asking Buildbucket for the build status
[18:30:01.581] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:01.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:124:0) after 1m0s
[18:31:01.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:124:0)
[18:31:01.636] Timer tick, asking Buildbucket for the build status
[18:31:01.752] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:01.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:125:0) after 1m0s
[18:32:01.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:125:0)
[18:32:01.787] Timer tick, asking Buildbucket for the build status
[18:32:01.870] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:01.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:126:0) after 1m0s
[18:33:01.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:126:0)
[18:33:01.908] Timer tick, asking Buildbucket for the build status
[18:33:01.951] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:01.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:127:0) after 1m0s
[18:34:01.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:127:0)
[18:34:01.998] Timer tick, asking Buildbucket for the build status
[18:34:02.465] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:02.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:128:0) after 1m0s
[18:35:02.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:128:0)
[18:35:02.708] Timer tick, asking Buildbucket for the build status
[18:35:02.891] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:02.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:129:0) after 1m0s
[18:36:02.932] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:129:0)
[18:36:02.932] Timer tick, asking Buildbucket for the build status
[18:36:03.040] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:03.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:130:0) after 1m0s
[18:37:03.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:130:0)
[18:37:03.188] Timer tick, asking Buildbucket for the build status
[18:37:03.273] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:03.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:131:0) after 1m0s
[18:38:03.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:131:0)
[18:38:03.369] Timer tick, asking Buildbucket for the build status
[18:38:03.408] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:03.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:132:0) after 1m0s
[18:39:03.438] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:132:0)
[18:39:03.438] Timer tick, asking Buildbucket for the build status
[18:39:03.541] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:03.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:133:0) after 1m0s
[18:40:03.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:133:0)
[18:40:03.568] Timer tick, asking Buildbucket for the build status
[18:40:03.645] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:03.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:134:0) after 1m0s
[18:41:03.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:134:0)
[18:41:03.715] Timer tick, asking Buildbucket for the build status
[18:41:03.810] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:135:0) after 1m0s
[18:42:03.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:135:0)
[18:42:03.833] Timer tick, asking Buildbucket for the build status
[18:42:03.908] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:03.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:136:0) after 1m0s
[18:43:03.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:136:0)
[18:43:03.976] Timer tick, asking Buildbucket for the build status
[18:43:04.069] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:04.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:137:0) after 1m0s
[18:44:04.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:137:0)
[18:44:04.098] Timer tick, asking Buildbucket for the build status
[18:44:04.237] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:04.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:138:0) after 1m0s
[18:45:04.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:138:0)
[18:45:04.268] Timer tick, asking Buildbucket for the build status
[18:45:04.332] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:04.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:139:0) after 1m0s
[18:46:04.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:139:0)
[18:46:04.378] Timer tick, asking Buildbucket for the build status
[18:46:04.417] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:04.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:140:0) after 1m0s
[18:47:04.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:140:0)
[18:47:04.497] Timer tick, asking Buildbucket for the build status
[18:47:04.571] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:04.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:141:0) after 1m0s
[18:48:04.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:141:0)
[18:48:04.596] Timer tick, asking Buildbucket for the build status
[18:48:04.661] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:04.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:142:0) after 1m0s
[18:49:04.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:142:0)
[18:49:04.698] Timer tick, asking Buildbucket for the build status
[18:49:05.824] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:05.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:143:0) after 1m0s
[18:50:05.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:143:0)
[18:50:05.864] Timer tick, asking Buildbucket for the build status
[18:50:05.905] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:05.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:144:0) after 1m0s
[18:51:05.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:144:0)
[18:51:05.940] Timer tick, asking Buildbucket for the build status
[18:51:06.000] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:06.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:145:0) after 1m0s
[18:52:06.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:145:0)
[18:52:06.034] Timer tick, asking Buildbucket for the build status
[18:52:06.103] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:06.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:146:0) after 1m0s
[18:53:06.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:146:0)
[18:53:06.129] Timer tick, asking Buildbucket for the build status
[18:53:06.191] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:06.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:147:0) after 1m0s
[18:54:06.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:147:0)
[18:54:06.251] Timer tick, asking Buildbucket for the build status
[18:54:06.293] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:06.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:148:0) after 1m0s
[18:55:06.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:148:0)
[18:55:06.316] Timer tick, asking Buildbucket for the build status
[18:55:06.355] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:06.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:149:0) after 1m0s
[18:56:06.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:149:0)
[18:56:06.385] Timer tick, asking Buildbucket for the build status
[18:56:06.458] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:06.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:150:0) after 1m0s
[18:57:06.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:150:0)
[18:57:06.485] Timer tick, asking Buildbucket for the build status
[18:57:06.562] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:06.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:151:0) after 1m0s
[18:58:06.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:151:0)
[18:58:06.622] Timer tick, asking Buildbucket for the build status
[18:58:06.673] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:06.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:152:0) after 1m0s
[18:59:06.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:152:0)
[18:59:06.737] Timer tick, asking Buildbucket for the build status
[18:59:06.800] Build 8934939686407065840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:06.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9100369748565797168:153:0) after 1m0s
[18:59:49.233] Received PubSub notification, asking Buildbucket for the build status
[18:59:49.289] Build 8934939686407065840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:59:49.289] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1537383588286029",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537374524642329",
"id": "8934939686407065840",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b18f54c0b3661dff00bbe578c75340c71c10770f\"}}",
"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/8934939686407065840/+/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\": [\"3772-022cb40\"], \"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\": \"6f1149defa9e40c9bd20512b5560959d381ac202\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"b18f54c0b3661dff00bbe578c75340c71c10770f\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24746}\", \"$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@{#592433}\", \"branch\": \"refs/heads/master\", \"revision\": \"b18f54c0b3661dff00bbe578c75340c71c10770f\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d574123c5035901107e4dd56a3cd0968f174a881\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"2c8f0845431dbbb8e712ad92a6f409c00de1e681\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1537374524642329, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9100369748565797168\", \"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\": \"8934939686407065840\"}}, \"got_v8_revision\": \"e4c6d03d3deaa661d0ca7f090877565f66c1a243\", \"got_v8_revision_cp\": \"refs/heads/7.1.137@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10138, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"85e279ac2cb35638056373ede35ebbfd3236614b\", \"notification_helper_unittests\": \"af00ebffa9654c42dae5c7273e9d9add73bcfadd\", \"gpu_perftests\": \"c830a1a6a7ab893198d11a4e9b28c1f51fa01482\", \"vr_common_unittests\": \"1699f575882d4df4ec5ff22ed4f9c25214a507ed\", \"telemetry_unittests\": \"072d10a92a428f25a322280bd02b4d4668c6655e\", \"load_library_perf_tests\": \"b9e213e53a004057e4c6c7edf34cf9d970ecee07\", \"devtools_closure_compile\": \"4500c6c99797a396652e019a04bd6ea8ea876313\", \"chromedriver_py_tests\": \"29eb408d800d27829462185c8e377e2962d8b597\", \"mojo_core_unittests\": \"230dab7912c8842914abc6122bdd7bf9e2c87ed3\", \"install_static_unittests\": \"7af095c67dc97489b228e2b3c7b01bda428f731f\", \"leveldb_service_unittests\": \"0669bc7ea9870cdfb4b97036a32aa584b9bd3ba2\", \"mini_installer_tests\": \"6def6c0e3f18e649213ea77f20ba0fb3c9f282a0\", \"jingle_unittests\": \"b592f03b0e6ded064c1c1304650a463e214da8b7\", \"sbox_integration_tests\": \"3b3e83509dea919709bcf979db7905202b47a6c5\", \"angle_unittests\": \"a627a1db380f43cd6fba786b4411768e3740d894\", \"cast_unittests\": \"1635725b0cbe8790cd1a9fe765260a5c28f58685\", \"cc_unittests\": \"3d5698bc155334213c3940bc3b58ea44d599c6a2\", \"blink_common_unittests\": \"96aced942d55f3e10c9e6106f2cc15fc5217ec70\", \"crashpad_tests\": \"472be77d1a015a3e4b3b3cc33eb4ac7ab7f0c3b2\", \"telemetry_perf_tests_without_chrome\": \"588636966fd2861a540cf9c002ace5b9812f44ff\", \"metrics_python_tests\": \"a54ccbdcb57a0d4e104d4d9469fa880fb724183b\", \"message_center_unittests\": \"d68fc0c60a5979c85c6fb130c5c0ad195709d668\", \"ppapi_unittests\": \"1722d7f3690386ae085381ecdbeaf19a86ae141d\", \"extensions_unittests\": \"3902eec4215c1e8a5da01fd416ceb6ca34a3c869\", \"gl_unittests_ozone\": \"5fc074b58a555dd1b55d5819df8586b43f7827d9\", \"app_shell_unittests\": \"619686a8bc02fb7c2f8958050435c4511d07f416\", \"chrome_app_unittests\": \"5a16d79b0a3e7d94cc148139240c7b0bf7912f33\", \"gl_unittests\": \"5fc074b58a555dd1b55d5819df8586b43f7827d9\", \"gcm_unit_tests\": \"ee41863648a02f59ef6a81bb1ecdd7b2519ebfbd\", \"views_unittests\": \"c8e07454c46244c33085d4da762a928e39fb5618\", \"content_shell_crash_test\": \"8f0aef681ece807cf3373f2a9c4156dfb8da6059\", \"ui_base_unittests\": \"2deaf15f8894d14af1f482a6df0190e35b5dfb11\", \"gles2_conform_test\": \"5d9d13cdc17e0cbe2088bcca658042cf3c6327d7\", \"cronet_unittests\": \"89a8c1aa8372251d891240dd3c03fbb6236e5e9f\", \"performance_test_suite\": \"75937d494db91bf922dd5fbd22056fc4a8fa5f0e\", \"wm_unittests\": \"2128b796fe3d9be0ea9e11f44043f490403a4b55\", \"boringssl_crypto_tests\": \"0cdac439b3eb5dcc062f484b171e9b9e308f3921\", \"gin_unittests\": \"96113f424a4b9939fc2c59fd34935dc5b447aa4a\", \"performance_browser_tests\": \"928a51da820ce8bdb3fef38a094cf61a9de2ae43\", \"extensions_browsertests\": \"bd8af4bc6a4a86bff6a99f660a1fde921bfe4536\", \"webkit_python_tests\": \"352b2560e96130f09fa453aa9225308108834929\", \"headless_unittests\": \"38cfca6690d99358de87a71b68519aa3ae5b3411\", \"webkit_layout_tests\": \"0a4f1b169a6e395e3fdd3e83d3d8efc54d19fb89\", \"vr_pixeltests\": \"d5aea944b05e53f7673c4405ebcc0f68423c7e86\", \"setup_unittests\": \"6127816ee7b09d18202060588d27a188c6587f02\", \"webkit_unit_tests\": \"da690a46dd9a22e19c94f5a1e0157903ff293ea8\", \"content_unittests\": \"43906a706a0ed5bb8bbf12a670fbd04459ae3852\", \"performance_webview_test_suite\": \"f0f30fbf8212df740a77dea33e42ef7ba9c985fb\", \"wtf_unittests\": \"3b85d2f57db33eb77390e6a20b3a097efa1c143e\", \"webkit_layout_tests_exparchive\": \"14a98c2d478c2c788ffcbebd17ba665c51071fb2\", \"chrome_cleaner_unittests\": \"4b451ff3a4468f77ea9d1aa7b9775589c1fa2ef7\", \"traffic_annotation_auditor_unittests\": \"24b76d44e55c85b483c45fac5ce2f40e9848b8a7\", \"libjingle_xmpp_unittests\": \"a1e6d4f274d396ee07bf33a7320adf9efa2a11e3\", \"remoting_unittests\": \"d87d06d1a85d56f5003278b3b9ae2149c3575ce8\", \"vr_common_perftests\": \"7a2ffefb1403f3bded890051ef843cb66151ff76\", \"filesystem_service_unittests\": \"713787dc28406d8505517c653f013874cb10fe20\", \"chrome_elf_import_unittests\": \"cfb226b745501b34557f7d0fa293990dea2611b2\", \"installer_util_unittests\": \"3e2756d79d979a0521ac7c1e916b98e27de758eb\", \"gfx_unittests\": \"f190ccf46d2ba614d496ac64e43fbefb18d1d52c\", \"headless_browsertests\": \"a3e2f4be2de814218d7ee0fc420c62ba693e716b\", \"capture_unittests\": \"8910fc87b53ead0f31278420497d4503e556cb25\", \"chrome_elf_unittests\": \"d71e16d0e995598c06bdcb2a4abfeb6f8c80966e\", \"telemetry_gpu_unittests\": \"fd0196f25eef2e6414e5338b6c6dd8a102828207\", \"command_buffer_perftests\": \"7b4d0a6584545984f8d5709b4ff267f3320af6d0\", \"media_unittests\": \"6197665be8e197e2e3a00800b56460e114046db5\", \"chromedriver_unittests\": \"d62fae5e366c510fa6f80f57c3c28f1d152c6510\", \"views_mus_interactive_ui_tests\": \"11f933bc94ef8a41c9e5491e76b64bf540d3af45\", \"storage_unittests\": \"96118ec4ac1cf506d5305612d746ef62ffa798c0\", \"media_service_unittests\": \"41b1dc9da44579b42e0d06db2a31929d5a033a99\", \"compositor_unittests\": \"df24e6d82184b8fea3fe1c4297d7066291491620\", \"latency_unittests\": \"989bad2d7368a26ae4eabdae28592c5d49a7a31d\", \"video_decode_accelerator_unittest\": \"22df4cff4dc80614f0b33e23ec6dfdea3a9add76\", \"swiftshader_unittests\": \"9a2def897f5b4d207b24723e533c456f3defe2d6\", \"telemetry_perf_unittests\": \"4282414d9deca412c8d2a5acbc8f9fe6fcc45b10\", \"media_blink_unittests\": \"ab156d7e8d047e48b62c38ac0503e7bef421272f\", \"views_mus_unittests\": \"31432f0e3e106f2068bd9455a7d819ca61fe2f5c\", \"components_unittests\": \"cd09603674f0a042fe9ea7bcd534f05cd20defc1\", \"snapshot_unittests\": \"cc052596f2e72496f4f31636a7389fdf8cb98e4e\", \"accessibility_unittests\": \"03f94c1e3ea1d4252411e6fc9aebb9411ecdddc2\", \"net_perftests\": \"9c913261e9ea3dfe33cf73077efa58844e1536b7\", \"aura_unittests\": \"ea644a65794235cd3b1d42e6cb5fee6563324987\", \"services_unittests\": \"6a06ee7a0f174a33a500d76131ff499c3615d18d\", \"components_perftests\": \"509d3e387e1a306041804f39af511cefb7f39a94\", \"events_unittests\": \"ff46b4f31f72f8f77e2e88755bd86078b2a4c738\", \"tracing_perftests\": \"f980b454db47b445eb79d9574c4039af9e93ed10\", \"chromedriver_replay_unittests\": \"8748d2066c857f4d7ccf421964b9a4af587ed290\", \"ui_touch_selection_unittests\": \"f18d7ac16b8ff1a6fc87e70f70684585b71a0c95\", \"cacheinvalidation_unittests\": \"ec18d45ca2e882757d7769180fec1fb021357d15\", \"viz_unittests\": \"4deffa299093d8cdd15e308b00f12c09cf06518c\", \"browser_tests\": \"1e0ef33c6eb0ba11faee00e43f7846ac583f9338\", \"net_unittests\": \"ddd6a31a475a8f07a529342a5e78b190a84b1f17\", \"midi_unittests\": \"d25b22431208afe8a2c7f01db72813676078845f\", \"boringssl_ssl_tests\": \"891d2775084ce1830a967a988cadc4b8d186486a\", \"sbox_validation_tests\": \"245f95810bc89dd15dcc9ed0574f4a96d719d23b\", \"elevation_service_unittests\": \"f54c9785cd3c587a819baeb1f6bb4f91fe1e46fd\", \"gpu_unittests\": \"0f9dd87df436da94a09b42299c26f0b550bcd133\", \"native_theme_unittests\": \"49b8a6dbfc8d8aa56216cad53db4a466cf902568\", \"interactive_ui_tests\": \"8f3e886083d2f73be4eb093f4ee6dc8936079807\", \"mojo_unittests\": \"bb70778131c5411e921ca3ec21a8b82341253fe5\", \"url_unittests\": \"89966397d33c352d21a314d95badeeba088fc033\", \"media_perftests\": \"c14d86b2e555df40af06d153162336f2acb9e2fa\", \"cronet_tests\": \"eea836863c5fe571a355d3132da7c230a983fea2\", \"google_apis_unittests\": \"9f9a0a9d13c71c34d1d6273adb69c6b4c4545e58\", \"telemetry_gpu_integration_test\": \"cf7aa9e5263908679547087926a148f3bec28f69\", \"blink_heap_unittests\": \"a6ddd2adc452ff635bfec82207ae60f77bae5315\", \"base_unittests\": \"24d2b8651c333c94aa8ef807c802ed12ace5563f\", \"sync_integration_tests\": \"4b7f992ac231ed3bf1f53853052c8faddf3369b3\", \"sql_unittests\": \"d3558cc86e834c91fd8eebd11a182d7d4c9213d7\", \"courgette_unittests\": \"78bfa0ecdeab8175f40aacd05755213402115b23\", \"blink_fuzzer_unittests\": \"234699786671ceb1a4fa6826efaee5bd6e8eb063\", \"gl_tests\": \"a6b75be5f1eb1fd3a868c82f33258ef832f54324\", \"zucchini_unittests\": \"d231320af85565a18b4a7dad7f33a45049c193b4\", \"ipc_tests\": \"9c27b20abb4b4e0f964689f63407e02e5df45d0b\", \"angle_end2end_tests\": \"213520837973ed50cba9f2f1d45f1d5dc2896b4d\", \"blink_platform_unittests\": \"ca65a0cca2022cc7699b45cfcbb7174264aa3773\", \"components_browsertests\": \"73037a27663a36574f82c03bfa0e5681a7e4bfd2\", \"views_perftests\": \"643e852144d8bc47c57cb04ec1d2deefd1d7e3ff\", \"angle_perftests\": \"835e9f47b930d608756c1ac43ea42311c83b69ee\", \"display_unittests\": \"30ce33818a485fa27acfe18d7c2c74017bc59b72\", \"sbox_unittests\": \"79f43a5ae2345d32aa5bcb998d4d56c9f4a6d026\", \"service_manager_unittests\": \"a4812f0ddad0ecc8e8b6b1d44ddeed4769ea1cc3\", \"pdf_unittests\": \"5bc7863ad1b318c6437421dec25e385d9c9e724e\", \"skia_unittests\": \"a3bff6a59ff477180377dcbd666e9cbb2c37ab09\", \"angle_white_box_tests\": \"4c316adc06103c5a178f897a00a6e3e95e8bfec1\", \"crypto_unittests\": \"b5e491507a32204d724a5971a16e02f4e90a4787\", \"nacl_loader_unittests\": \"a8d14a8e9da9273dc30082fe5edee46564c7351d\", \"unit_tests\": \"9b15c8fb7033594cae8d8b8426450ef947f8126e\", \"content_browsertests\": \"b36771faa20575e9fa66f4bccc7778a2df9752de\", \"printing_unittests\": \"549e20c8ab923d50421ffb11fe33e78a5860bd16\", \"device_unittests\": \"ae6431f3dc000bc7149e9923adbc149b33e501db\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1537374530386316",
"status": "COMPLETED",
"status_changed_ts": "1537383588701954",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10138",
"builder:Windows deterministic",
"buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9100369748565797168",
"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/10138",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934939686407065840",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:ca2c7a741e04d0385e2bf62941ac932dc0521af3",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/b18f54c0b3661dff00bbe578c75340c71c10770f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b18f54c0b3661dff00bbe578c75340c71c10770f",
"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/8934939686407065840/+/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:9100369748565797168",
"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:731a34751ed7c0e7d53ce68735dc569104507fe4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:400b7b1f5d953a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1537383588703472",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10138",
"utcnow_ts": "1537383589277288"
}
}
[18:59:49.289] Invocation finished in 2h31m6.088866818s with status SUCCEEDED