[17:43:44.151] New invocation is queued and will start shortly
[17:43:45.596] Starting the invocation (attempt 1)
[17:43:45.630] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:43:45.630] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:43:45.630] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9104985474281517600",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"cdf541470ddd2b2060608345a50e36c5f6b51d5f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9104985474281517600",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"gitiles_ref:refs/heads/master"
]
}
[17:43:46.775] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532972625733890",
"id": "8939555411957804432",
"lease_expiration_ts": "1533116626424180",
"lease_key": "1273290165",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cdf541470ddd2b2060608345a50e36c5f6b51d5f\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1532972626685410",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9611",
"builder:Windows deterministic",
"buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9104985474281517600",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9611",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939555411957804432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"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/8939555411957804432/+/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:9104985474281517600",
"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:b8825e1369b8060da18e1f3e340afb3fc7c3cd54",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f051b79411b6710",
"user_agent:luci-scheduler"
],
"updated_ts": "1532972626685720",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9611",
"utcnow_ts": "1532972626760070"
}
}
[17:43:46.775] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9611
[17:43:46.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:2:0) after 1m0s
[17:44:46.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:2:0)
[17:44:46.802] Timer tick, asking Buildbucket for the build status
[17:44:46.860] Build 8939555411957804432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:44:46.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:3:0) after 1m0s
[17:45:46.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:3:0)
[17:45:46.918] Timer tick, asking Buildbucket for the build status
[17:45:47.109] Build 8939555411957804432: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[17:45:47.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:4:0) after 1m0s
[17:45:52.850] Received PubSub notification, asking Buildbucket for the build status
[17:45:53.032] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:47.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:4:0)
[17:46:47.239] Timer tick, asking Buildbucket for the build status
[17:46:47.277] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:47.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:6:0) after 1m0s
[17:47:47.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:6:0)
[17:47:47.315] Timer tick, asking Buildbucket for the build status
[17:47:47.405] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:47.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:7:0) after 1m0s
[17:48:47.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:7:0)
[17:48:47.458] Timer tick, asking Buildbucket for the build status
[17:48:47.526] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:47.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:8:0) after 1m0s
[17:49:47.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:8:0)
[17:49:47.569] Timer tick, asking Buildbucket for the build status
[17:49:47.666] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:47.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:9:0) after 1m0s
[17:50:47.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:9:0)
[17:50:47.690] Timer tick, asking Buildbucket for the build status
[17:50:47.760] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:47.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:10:0) after 1m0s
[17:51:47.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:10:0)
[17:51:47.782] Timer tick, asking Buildbucket for the build status
[17:51:47.858] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:47.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:11:0) after 1m0s
[17:52:47.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:11:0)
[17:52:47.886] Timer tick, asking Buildbucket for the build status
[17:52:47.936] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:47.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:12:0) after 1m0s
[17:53:47.957] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:12:0)
[17:53:47.957] Timer tick, asking Buildbucket for the build status
[17:53:48.212] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:48.212] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:13:0) after 1m0s
[17:54:48.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:13:0)
[17:54:48.284] Timer tick, asking Buildbucket for the build status
[17:54:48.396] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:48.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:14:0) after 1m0s
[17:55:48.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:14:0)
[17:55:48.424] Timer tick, asking Buildbucket for the build status
[17:55:48.531] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:48.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:15:0) after 1m0s
[17:56:48.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:15:0)
[17:56:48.552] Timer tick, asking Buildbucket for the build status
[17:56:48.656] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:48.656] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:16:0) after 1m0s
[17:57:48.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:16:0)
[17:57:48.686] Timer tick, asking Buildbucket for the build status
[17:57:48.802] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:48.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:17:0) after 1m0s
[17:58:48.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:17:0)
[17:58:48.821] Timer tick, asking Buildbucket for the build status
[17:58:49.027] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:49.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:18:0) after 1m0s
[17:59:49.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:18:0)
[17:59:49.079] Timer tick, asking Buildbucket for the build status
[17:59:49.168] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:49.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:19:0) after 1m0s
[18:00:49.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:19:0)
[18:00:49.217] Timer tick, asking Buildbucket for the build status
[18:00:49.321] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:49.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:20:0) after 1m0s
[18:01:49.394] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:20:0)
[18:01:49.394] Timer tick, asking Buildbucket for the build status
[18:01:49.441] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:49.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:21:0) after 1m0s
[18:02:49.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:21:0)
[18:02:49.573] Timer tick, asking Buildbucket for the build status
[18:02:49.705] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:49.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:22:0) after 1m0s
[18:03:49.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:22:0)
[18:03:49.727] Timer tick, asking Buildbucket for the build status
[18:03:49.832] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:49.832] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:23:0) after 1m0s
[18:04:49.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:23:0)
[18:04:49.901] Timer tick, asking Buildbucket for the build status
[18:04:49.945] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:49.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:24:0) after 1m0s
[18:05:49.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:24:0)
[18:05:49.971] Timer tick, asking Buildbucket for the build status
[18:05:50.028] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:50.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:25:0) after 1m0s
[18:06:50.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:25:0)
[18:06:50.060] Timer tick, asking Buildbucket for the build status
[18:06:50.103] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:50.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:26:0) after 1m0s
[18:07:50.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:26:0)
[18:07:50.122] Timer tick, asking Buildbucket for the build status
[18:07:50.166] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:50.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:27:0) after 1m0s
[18:08:50.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:27:0)
[18:08:50.220] Timer tick, asking Buildbucket for the build status
[18:08:50.275] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:50.275] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:28:0) after 1m0s
[18:09:50.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:28:0)
[18:09:50.295] Timer tick, asking Buildbucket for the build status
[18:09:50.336] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:50.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:29:0) after 1m0s
[18:10:50.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:29:0)
[18:10:50.357] Timer tick, asking Buildbucket for the build status
[18:10:50.430] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:50.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:30:0) after 1m0s
[18:11:50.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:30:0)
[18:11:50.455] Timer tick, asking Buildbucket for the build status
[18:11:50.491] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:50.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:31:0) after 1m0s
[18:12:50.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:31:0)
[18:12:50.510] Timer tick, asking Buildbucket for the build status
[18:12:50.665] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:32:0) after 1m0s
[18:13:50.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:32:0)
[18:13:50.684] Timer tick, asking Buildbucket for the build status
[18:13:50.746] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:50.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:33:0) after 1m0s
[18:14:50.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:33:0)
[18:14:50.780] Timer tick, asking Buildbucket for the build status
[18:14:50.818] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:50.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:34:0) after 1m0s
[18:15:50.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:34:0)
[18:15:50.841] Timer tick, asking Buildbucket for the build status
[18:15:50.877] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:50.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:35:0) after 1m0s
[18:16:51.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:35:0)
[18:16:51.049] Timer tick, asking Buildbucket for the build status
[18:16:51.203] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:51.203] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:36:0) after 1m0s
[18:17:51.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:36:0)
[18:17:51.225] Timer tick, asking Buildbucket for the build status
[18:17:51.293] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:51.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:37:0) after 1m0s
[18:18:51.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:37:0)
[18:18:51.319] Timer tick, asking Buildbucket for the build status
[18:18:51.357] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:51.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:38:0) after 1m0s
[18:19:51.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:38:0)
[18:19:51.396] Timer tick, asking Buildbucket for the build status
[18:19:51.431] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:51.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:39:0) after 1m0s
[18:20:51.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:39:0)
[18:20:51.476] Timer tick, asking Buildbucket for the build status
[18:20:51.618] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:51.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:40:0) after 1m0s
[18:21:51.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:40:0)
[18:21:51.655] Timer tick, asking Buildbucket for the build status
[18:21:51.697] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:51.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:41:0) after 1m0s
[18:22:51.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:41:0)
[18:22:51.743] Timer tick, asking Buildbucket for the build status
[18:22:51.811] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:51.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:42:0) after 1m0s
[18:23:51.831] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:42:0)
[18:23:51.831] Timer tick, asking Buildbucket for the build status
[18:23:51.868] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:51.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:43:0) after 1m0s
[18:24:51.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:43:0)
[18:24:51.971] Timer tick, asking Buildbucket for the build status
[18:24:52.033] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:52.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:44:0) after 1m0s
[18:25:52.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:44:0)
[18:25:52.056] Timer tick, asking Buildbucket for the build status
[18:25:52.098] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:52.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:45:0) after 1m0s
[18:26:52.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:45:0)
[18:26:52.206] Timer tick, asking Buildbucket for the build status
[18:26:52.309] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:52.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:46:0) after 1m0s
[18:27:52.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:46:0)
[18:27:52.471] Timer tick, asking Buildbucket for the build status
[18:27:52.655] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:52.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:47:0) after 1m0s
[18:28:52.677] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:47:0)
[18:28:52.677] Timer tick, asking Buildbucket for the build status
[18:28:52.728] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:52.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:48:0) after 1m0s
[18:29:52.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:48:0)
[18:29:52.763] Timer tick, asking Buildbucket for the build status
[18:29:52.834] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:52.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:49:0) after 1m0s
[18:30:52.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:49:0)
[18:30:52.909] Timer tick, asking Buildbucket for the build status
[18:30:53.024] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:53.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:50:0) after 1m0s
[18:31:53.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:50:0)
[18:31:53.056] Timer tick, asking Buildbucket for the build status
[18:31:53.128] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:53.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:51:0) after 1m0s
[18:32:53.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:51:0)
[18:32:53.149] Timer tick, asking Buildbucket for the build status
[18:32:53.360] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:53.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:52:0) after 1m0s
[18:33:53.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:52:0)
[18:33:53.391] Timer tick, asking Buildbucket for the build status
[18:33:53.552] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:53.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:53:0) after 1m0s
[18:34:53.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:53:0)
[18:34:53.575] Timer tick, asking Buildbucket for the build status
[18:34:53.641] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:53.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:54:0) after 1m0s
[18:35:53.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:54:0)
[18:35:53.711] Timer tick, asking Buildbucket for the build status
[18:35:53.745] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:53.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:55:0) after 1m0s
[18:36:53.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:55:0)
[18:36:53.778] Timer tick, asking Buildbucket for the build status
[18:36:53.835] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:53.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:56:0) after 1m0s
[18:37:53.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:56:0)
[18:37:53.950] Timer tick, asking Buildbucket for the build status
[18:37:54.011] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:54.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:57:0) after 1m0s
[18:38:54.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:57:0)
[18:38:54.121] Timer tick, asking Buildbucket for the build status
[18:38:54.204] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:54.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:58:0) after 1m0s
[18:39:54.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:58:0)
[18:39:54.228] Timer tick, asking Buildbucket for the build status
[18:39:54.395] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:54.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:59:0) after 1m0s
[18:40:54.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:59:0)
[18:40:54.455] Timer tick, asking Buildbucket for the build status
[18:40:54.543] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:54.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:60:0) after 1m0s
[18:41:54.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:60:0)
[18:41:54.580] Timer tick, asking Buildbucket for the build status
[18:41:54.621] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:54.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:61:0) after 1m0s
[18:42:54.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:61:0)
[18:42:54.765] Timer tick, asking Buildbucket for the build status
[18:42:54.822] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:54.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:62:0) after 1m0s
[18:43:54.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:62:0)
[18:43:54.850] Timer tick, asking Buildbucket for the build status
[18:43:55.032] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:55.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:63:0) after 1m0s
[18:44:55.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:63:0)
[18:44:55.055] Timer tick, asking Buildbucket for the build status
[18:44:55.106] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:55.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:64:0) after 1m0s
[18:45:55.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:64:0)
[18:45:55.143] Timer tick, asking Buildbucket for the build status
[18:45:55.190] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:55.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:65:0) after 1m0s
[18:46:55.291] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:65:0)
[18:46:55.291] Timer tick, asking Buildbucket for the build status
[18:46:55.332] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:55.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:66:0) after 1m0s
[18:47:55.360] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:66:0)
[18:47:55.360] Timer tick, asking Buildbucket for the build status
[18:47:55.400] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:55.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:67:0) after 1m0s
[18:48:55.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:67:0)
[18:48:55.475] Timer tick, asking Buildbucket for the build status
[18:48:55.535] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:55.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:68:0) after 1m0s
[18:49:55.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:68:0)
[18:49:55.555] Timer tick, asking Buildbucket for the build status
[18:49:55.598] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:55.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:69:0) after 1m0s
[18:50:55.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:69:0)
[18:50:55.621] Timer tick, asking Buildbucket for the build status
[18:50:55.703] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:55.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:70:0) after 1m0s
[18:51:55.731] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:70:0)
[18:51:55.731] Timer tick, asking Buildbucket for the build status
[18:51:55.784] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:55.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:71:0) after 1m0s
[18:52:55.805] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:71:0)
[18:52:55.805] Timer tick, asking Buildbucket for the build status
[18:52:55.866] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:55.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:72:0) after 1m0s
[18:53:55.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:72:0)
[18:53:55.952] Timer tick, asking Buildbucket for the build status
[18:53:56.054] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:56.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:73:0) after 1m0s
[18:54:56.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:73:0)
[18:54:56.310] Timer tick, asking Buildbucket for the build status
[18:54:56.352] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:56.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:74:0) after 1m0s
[18:55:56.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:74:0)
[18:55:56.455] Timer tick, asking Buildbucket for the build status
[18:55:56.645] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:56.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:75:0) after 1m0s
[18:56:56.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:75:0)
[18:56:56.772] Timer tick, asking Buildbucket for the build status
[18:56:56.815] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:56.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:76:0) after 1m0s
[18:57:56.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:76:0)
[18:57:56.840] Timer tick, asking Buildbucket for the build status
[18:57:56.884] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:56.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:77:0) after 1m0s
[18:58:56.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:77:0)
[18:58:56.908] Timer tick, asking Buildbucket for the build status
[18:58:56.944] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:56.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:78:0) after 1m0s
[18:59:56.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:78:0)
[18:59:56.965] Timer tick, asking Buildbucket for the build status
[18:59:57.062] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:57.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:79:0) after 1m0s
[19:00:57.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:79:0)
[19:00:57.085] Timer tick, asking Buildbucket for the build status
[19:00:57.123] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:57.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:80:0) after 1m0s
[19:01:57.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:80:0)
[19:01:57.163] Timer tick, asking Buildbucket for the build status
[19:01:57.226] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:57.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:81:0) after 1m0s
[19:02:57.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:81:0)
[19:02:57.258] Timer tick, asking Buildbucket for the build status
[19:02:57.315] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:57.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:82:0) after 1m0s
[19:03:57.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:82:0)
[19:03:57.403] Timer tick, asking Buildbucket for the build status
[19:03:57.473] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:57.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:83:0) after 1m0s
[19:04:57.494] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:83:0)
[19:04:57.494] Timer tick, asking Buildbucket for the build status
[19:04:57.538] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:57.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:84:0) after 1m0s
[19:05:57.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:84:0)
[19:05:57.570] Timer tick, asking Buildbucket for the build status
[19:05:57.686] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:57.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:85:0) after 1m0s
[19:06:57.713] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:85:0)
[19:06:57.713] Timer tick, asking Buildbucket for the build status
[19:06:57.831] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:57.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:86:0) after 1m0s
[19:07:57.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:86:0)
[19:07:57.850] Timer tick, asking Buildbucket for the build status
[19:07:57.916] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:57.916] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:87:0) after 1m0s
[19:08:57.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:87:0)
[19:08:57.950] Timer tick, asking Buildbucket for the build status
[19:08:57.987] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:57.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:88:0) after 1m0s
[19:09:58.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:88:0)
[19:09:58.009] Timer tick, asking Buildbucket for the build status
[19:09:58.125] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:58.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:89:0) after 1m0s
[19:10:58.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:89:0)
[19:10:58.428] Timer tick, asking Buildbucket for the build status
[19:10:58.500] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:58.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:90:0) after 1m0s
[19:11:58.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:90:0)
[19:11:58.529] Timer tick, asking Buildbucket for the build status
[19:11:58.665] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:58.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:91:0) after 1m0s
[19:12:58.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:91:0)
[19:12:58.710] Timer tick, asking Buildbucket for the build status
[19:12:58.800] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:58.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:92:0) after 1m0s
[19:13:58.819] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:92:0)
[19:13:58.819] Timer tick, asking Buildbucket for the build status
[19:13:58.906] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:58.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:93:0) after 1m0s
[19:14:58.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:93:0)
[19:14:58.934] Timer tick, asking Buildbucket for the build status
[19:14:58.980] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:58.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:94:0) after 1m0s
[19:15:59.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:94:0)
[19:15:59.004] Timer tick, asking Buildbucket for the build status
[19:15:59.074] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:59.074] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:95:0) after 1m0s
[19:16:59.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:95:0)
[19:16:59.187] Timer tick, asking Buildbucket for the build status
[19:16:59.251] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:59.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:96:0) after 1m0s
[19:17:59.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:96:0)
[19:17:59.276] Timer tick, asking Buildbucket for the build status
[19:17:59.333] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:59.333] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:97:0) after 1m0s
[19:18:59.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:97:0)
[19:18:59.356] Timer tick, asking Buildbucket for the build status
[19:18:59.391] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:59.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:98:0) after 1m0s
[19:19:59.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:98:0)
[19:19:59.415] Timer tick, asking Buildbucket for the build status
[19:19:59.465] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:59.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:99:0) after 1m0s
[19:20:59.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:99:0)
[19:20:59.508] Timer tick, asking Buildbucket for the build status
[19:20:59.629] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:59.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:100:0) after 1m0s
[19:21:59.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:100:0)
[19:21:59.659] Timer tick, asking Buildbucket for the build status
[19:21:59.732] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:59.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:101:0) after 1m0s
[19:22:59.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:101:0)
[19:22:59.753] Timer tick, asking Buildbucket for the build status
[19:22:59.868] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:59.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:102:0) after 1m0s
[19:23:59.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:102:0)
[19:23:59.893] Timer tick, asking Buildbucket for the build status
[19:23:59.953] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:59.953] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:103:0) after 1m0s
[19:24:59.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:103:0)
[19:24:59.981] Timer tick, asking Buildbucket for the build status
[19:25:00.234] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:00.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:104:0) after 1m0s
[19:26:00.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:104:0)
[19:26:00.255] Timer tick, asking Buildbucket for the build status
[19:26:00.530] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:105:0) after 1m0s
[19:27:00.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:105:0)
[19:27:00.552] Timer tick, asking Buildbucket for the build status
[19:27:00.752] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:00.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:106:0) after 1m0s
[19:28:00.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:106:0)
[19:28:00.800] Timer tick, asking Buildbucket for the build status
[19:28:00.996] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:00.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:107:0) after 1m0s
[19:29:01.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:107:0)
[19:29:01.023] Timer tick, asking Buildbucket for the build status
[19:29:07.645] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:07.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:108:0) after 1m0s
[19:30:07.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:108:0)
[19:30:07.665] Timer tick, asking Buildbucket for the build status
[19:30:07.702] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:07.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:109:0) after 1m0s
[19:31:07.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:109:0)
[19:31:07.725] Timer tick, asking Buildbucket for the build status
[19:31:07.857] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:07.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:110:0) after 1m0s
[19:32:07.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:110:0)
[19:32:07.891] Timer tick, asking Buildbucket for the build status
[19:32:08.092] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:08.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:111:0) after 1m0s
[19:33:08.127] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:111:0)
[19:33:08.127] Timer tick, asking Buildbucket for the build status
[19:33:08.200] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:08.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:112:0) after 1m0s
[19:34:08.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:112:0)
[19:34:08.222] Timer tick, asking Buildbucket for the build status
[19:34:08.341] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:08.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:113:0) after 1m0s
[19:35:08.434] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:113:0)
[19:35:08.434] Timer tick, asking Buildbucket for the build status
[19:35:08.544] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:08.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:114:0) after 1m0s
[19:36:08.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:114:0)
[19:36:08.566] Timer tick, asking Buildbucket for the build status
[19:36:08.815] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:08.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:115:0) after 1m0s
[19:37:08.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:115:0)
[19:37:08.835] Timer tick, asking Buildbucket for the build status
[19:37:08.895] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:08.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:116:0) after 1m0s
[19:38:08.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:116:0)
[19:38:08.934] Timer tick, asking Buildbucket for the build status
[19:38:08.975] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:08.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:117:0) after 1m0s
[19:39:09.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:117:0)
[19:39:09.001] Timer tick, asking Buildbucket for the build status
[19:39:09.096] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:09.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:118:0) after 1m0s
[19:40:09.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:118:0)
[19:40:09.120] Timer tick, asking Buildbucket for the build status
[19:40:09.179] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:09.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:119:0) after 1m0s
[19:41:09.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:119:0)
[19:41:09.202] Timer tick, asking Buildbucket for the build status
[19:41:09.324] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:09.324] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:120:0) after 1m0s
[19:42:09.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:120:0)
[19:42:09.349] Timer tick, asking Buildbucket for the build status
[19:42:09.413] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:09.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:121:0) after 1m0s
[19:43:09.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:121:0)
[19:43:09.443] Timer tick, asking Buildbucket for the build status
[19:43:09.541] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:09.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:122:0) after 1m0s
[19:44:09.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:122:0)
[19:44:09.573] Timer tick, asking Buildbucket for the build status
[19:44:09.645] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:09.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:123:0) after 1m0s
[19:45:09.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:123:0)
[19:45:09.668] Timer tick, asking Buildbucket for the build status
[19:45:09.702] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:09.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:124:0) after 1m0s
[19:46:09.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:124:0)
[19:46:09.727] Timer tick, asking Buildbucket for the build status
[19:46:09.767] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:46:09.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:125:0) after 1m0s
[19:47:09.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:125:0)
[19:47:09.789] Timer tick, asking Buildbucket for the build status
[19:47:09.851] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:47:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:126:0) after 1m0s
[19:48:09.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:126:0)
[19:48:09.878] Timer tick, asking Buildbucket for the build status
[19:48:09.924] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:48:09.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:127:0) after 1m0s
[19:49:09.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:127:0)
[19:49:09.948] Timer tick, asking Buildbucket for the build status
[19:49:09.989] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:49:09.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:128:0) after 1m0s
[19:50:10.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:128:0)
[19:50:10.009] Timer tick, asking Buildbucket for the build status
[19:50:10.356] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:50:10.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:129:0) after 1m0s
[19:51:10.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:129:0)
[19:51:10.392] Timer tick, asking Buildbucket for the build status
[19:51:10.526] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:51:10.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:130:0) after 1m0s
[19:52:10.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:130:0)
[19:52:10.555] Timer tick, asking Buildbucket for the build status
[19:52:10.837] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:52:10.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:131:0) after 1m0s
[19:53:10.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:131:0)
[19:53:10.905] Timer tick, asking Buildbucket for the build status
[19:53:11.031] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:53:11.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:132:0) after 1m0s
[19:54:11.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:132:0)
[19:54:11.061] Timer tick, asking Buildbucket for the build status
[19:54:11.098] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:54:11.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:133:0) after 1m0s
[19:55:11.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:133:0)
[19:55:11.125] Timer tick, asking Buildbucket for the build status
[19:55:11.172] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:55:11.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:134:0) after 1m0s
[19:56:11.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:134:0)
[19:56:11.203] Timer tick, asking Buildbucket for the build status
[19:56:11.266] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:56:11.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:135:0) after 1m0s
[19:57:11.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:135:0)
[19:57:11.302] Timer tick, asking Buildbucket for the build status
[19:57:11.424] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:57:11.424] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:136:0) after 1m0s
[19:58:11.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:136:0)
[19:58:11.446] Timer tick, asking Buildbucket for the build status
[19:58:11.494] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:58:11.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:137:0) after 1m0s
[19:59:11.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:137:0)
[19:59:11.528] Timer tick, asking Buildbucket for the build status
[19:59:11.646] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:59:11.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:138:0) after 1m0s
[20:00:11.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:138:0)
[20:00:11.668] Timer tick, asking Buildbucket for the build status
[20:00:11.717] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:00:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:139:0) after 1m0s
[20:01:11.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:139:0)
[20:01:11.746] Timer tick, asking Buildbucket for the build status
[20:01:11.877] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:11.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:140:0) after 1m0s
[20:02:11.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:140:0)
[20:02:11.900] Timer tick, asking Buildbucket for the build status
[20:02:11.962] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:11.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:141:0) after 1m0s
[20:03:11.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:141:0)
[20:03:11.989] Timer tick, asking Buildbucket for the build status
[20:03:12.352] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:12.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:142:0) after 1m0s
[20:04:12.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:142:0)
[20:04:12.415] Timer tick, asking Buildbucket for the build status
[20:04:12.505] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:12.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:143:0) after 1m0s
[20:05:12.530] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:143:0)
[20:05:12.530] Timer tick, asking Buildbucket for the build status
[20:05:12.697] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:12.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:144:0) after 1m0s
[20:06:12.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:144:0)
[20:06:12.724] Timer tick, asking Buildbucket for the build status
[20:06:12.784] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:12.784] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:145:0) after 1m0s
[20:07:12.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:145:0)
[20:07:12.809] Timer tick, asking Buildbucket for the build status
[20:07:12.851] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:12.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:146:0) after 1m0s
[20:08:12.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:146:0)
[20:08:12.899] Timer tick, asking Buildbucket for the build status
[20:08:12.948] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:12.948] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:147:0) after 1m0s
[20:09:12.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:147:0)
[20:09:12.971] Timer tick, asking Buildbucket for the build status
[20:09:13.052] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:13.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:148:0) after 1m0s
[20:10:13.082] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:148:0)
[20:10:13.082] Timer tick, asking Buildbucket for the build status
[20:10:13.139] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:13.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:149:0) after 1m0s
[20:11:13.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:149:0)
[20:11:13.162] Timer tick, asking Buildbucket for the build status
[20:11:13.210] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:13.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:150:0) after 1m0s
[20:12:13.253] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:150:0)
[20:12:13.253] Timer tick, asking Buildbucket for the build status
[20:12:13.532] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:13.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:151:0) after 1m0s
[20:13:13.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:151:0)
[20:13:13.597] Timer tick, asking Buildbucket for the build status
[20:13:13.697] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:13.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:152:0) after 1m0s
[20:14:13.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:152:0)
[20:14:13.724] Timer tick, asking Buildbucket for the build status
[20:14:13.771] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:13.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:153:0) after 1m0s
[20:15:13.798] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:153:0)
[20:15:13.798] Timer tick, asking Buildbucket for the build status
[20:15:13.881] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:13.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:154:0) after 1m0s
[20:16:13.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:154:0)
[20:16:13.907] Timer tick, asking Buildbucket for the build status
[20:16:14.205] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:14.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:155:0) after 1m0s
[20:17:14.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:155:0)
[20:17:14.258] Timer tick, asking Buildbucket for the build status
[20:17:14.451] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:14.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:156:0) after 1m0s
[20:18:14.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:156:0)
[20:18:14.475] Timer tick, asking Buildbucket for the build status
[20:18:14.503] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:14.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:157:0) after 1m0s
[20:19:14.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:157:0)
[20:19:14.533] Timer tick, asking Buildbucket for the build status
[20:19:14.571] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:14.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:158:0) after 1m0s
[20:20:14.595] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:158:0)
[20:20:14.595] Timer tick, asking Buildbucket for the build status
[20:20:14.650] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:14.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:159:0) after 1m0s
[20:21:14.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:159:0)
[20:21:14.689] Timer tick, asking Buildbucket for the build status
[20:21:14.778] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:14.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:160:0) after 1m0s
[20:22:14.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:160:0)
[20:22:14.804] Timer tick, asking Buildbucket for the build status
[20:22:14.902] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:14.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:161:0) after 1m0s
[20:23:14.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:161:0)
[20:23:14.927] Timer tick, asking Buildbucket for the build status
[20:23:15.001] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:15.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:162:0) after 1m0s
[20:24:15.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:162:0)
[20:24:15.027] Timer tick, asking Buildbucket for the build status
[20:24:15.078] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:15.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:163:0) after 1m0s
[20:25:15.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:163:0)
[20:25:15.102] Timer tick, asking Buildbucket for the build status
[20:25:15.220] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:15.220] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:164:0) after 1m0s
[20:26:15.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:164:0)
[20:26:15.274] Timer tick, asking Buildbucket for the build status
[20:26:15.319] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:15.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:165:0) after 1m0s
[20:27:15.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:165:0)
[20:27:15.425] Timer tick, asking Buildbucket for the build status
[20:27:15.533] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:166:0) after 1m0s
[20:28:15.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:166:0)
[20:28:15.618] Timer tick, asking Buildbucket for the build status
[20:28:15.676] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:15.676] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:167:0) after 1m0s
[20:29:15.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:167:0)
[20:29:15.738] Timer tick, asking Buildbucket for the build status
[20:29:15.794] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:15.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:168:0) after 1m0s
[20:30:15.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:168:0)
[20:30:15.821] Timer tick, asking Buildbucket for the build status
[20:30:15.856] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:15.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:169:0) after 1m0s
[20:31:15.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:169:0)
[20:31:15.881] Timer tick, asking Buildbucket for the build status
[20:31:16.072] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:16.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:170:0) after 1m0s
[20:32:16.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:170:0)
[20:32:16.346] Timer tick, asking Buildbucket for the build status
[20:32:16.532] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:16.532] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:171:0) after 1m0s
[20:33:16.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:171:0)
[20:33:16.559] Timer tick, asking Buildbucket for the build status
[20:33:16.616] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:16.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:172:0) after 1m0s
[20:34:16.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:172:0)
[20:34:16.708] Timer tick, asking Buildbucket for the build status
[20:34:16.775] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:16.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:173:0) after 1m0s
[20:35:16.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:173:0)
[20:35:16.912] Timer tick, asking Buildbucket for the build status
[20:35:16.975] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:16.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:174:0) after 1m0s
[20:36:17.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:174:0)
[20:36:17.002] Timer tick, asking Buildbucket for the build status
[20:36:17.049] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:17.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:175:0) after 1m0s
[20:37:17.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:175:0)
[20:37:17.074] Timer tick, asking Buildbucket for the build status
[20:37:17.128] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:17.128] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:176:0) after 1m0s
[20:38:17.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:176:0)
[20:38:17.163] Timer tick, asking Buildbucket for the build status
[20:38:17.772] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:17.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:177:0) after 1m0s
[20:39:17.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:177:0)
[20:39:17.899] Timer tick, asking Buildbucket for the build status
[20:39:18.000] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:18.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:178:0) after 1m0s
[20:40:18.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:178:0)
[20:40:18.024] Timer tick, asking Buildbucket for the build status
[20:40:18.079] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:18.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:179:0) after 1m0s
[20:41:18.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:179:0)
[20:41:18.122] Timer tick, asking Buildbucket for the build status
[20:41:18.237] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:18.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:180:0) after 1m0s
[20:42:18.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:180:0)
[20:42:18.328] Timer tick, asking Buildbucket for the build status
[20:42:18.375] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:18.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:181:0) after 1m0s
[20:43:18.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:181:0)
[20:43:18.408] Timer tick, asking Buildbucket for the build status
[20:43:18.763] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:18.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:182:0) after 1m0s
[20:44:18.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:182:0)
[20:44:18.785] Timer tick, asking Buildbucket for the build status
[20:44:18.835] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:18.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:183:0) after 1m0s
[20:45:18.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:183:0)
[20:45:18.901] Timer tick, asking Buildbucket for the build status
[20:45:19.063] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:19.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:184:0) after 1m0s
[20:46:19.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:184:0)
[20:46:19.089] Timer tick, asking Buildbucket for the build status
[20:46:19.188] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:19.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:185:0) after 1m0s
[20:47:19.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:185:0)
[20:47:19.213] Timer tick, asking Buildbucket for the build status
[20:47:19.300] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:19.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:186:0) after 1m0s
[20:48:19.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:186:0)
[20:48:19.327] Timer tick, asking Buildbucket for the build status
[20:48:19.463] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:19.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:187:0) after 1m0s
[20:49:19.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:187:0)
[20:49:19.485] Timer tick, asking Buildbucket for the build status
[20:49:19.624] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:19.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:188:0) after 1m0s
[20:50:19.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:188:0)
[20:50:19.653] Timer tick, asking Buildbucket for the build status
[20:50:19.754] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:19.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:189:0) after 1m0s
[20:51:19.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:189:0)
[20:51:19.866] Timer tick, asking Buildbucket for the build status
[20:51:19.942] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:19.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:190:0) after 1m0s
[20:52:20.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:190:0)
[20:52:20.153] Timer tick, asking Buildbucket for the build status
[20:52:20.202] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:20.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:191:0) after 1m0s
[20:53:20.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:191:0)
[20:53:20.226] Timer tick, asking Buildbucket for the build status
[20:53:20.293] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:20.293] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:192:0) after 1m0s
[20:54:20.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:192:0)
[20:54:20.405] Timer tick, asking Buildbucket for the build status
[20:54:20.708] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:20.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:193:0) after 1m0s
[20:55:20.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:193:0)
[20:55:20.735] Timer tick, asking Buildbucket for the build status
[20:55:20.785] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:20.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:194:0) after 1m0s
[20:56:20.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:194:0)
[20:56:20.838] Timer tick, asking Buildbucket for the build status
[20:56:20.876] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:20.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:195:0) after 1m0s
[20:57:21.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:195:0)
[20:57:21.015] Timer tick, asking Buildbucket for the build status
[20:57:21.067] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:21.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:196:0) after 1m0s
[20:58:21.095] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:196:0)
[20:58:21.095] Timer tick, asking Buildbucket for the build status
[20:58:21.232] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:21.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:197:0) after 1m0s
[20:59:21.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:197:0)
[20:59:21.266] Timer tick, asking Buildbucket for the build status
[20:59:21.339] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:21.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:198:0) after 1m0s
[21:00:21.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:198:0)
[21:00:21.403] Timer tick, asking Buildbucket for the build status
[21:00:21.444] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:21.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:199:0) after 1m0s
[21:01:21.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:199:0)
[21:01:21.505] Timer tick, asking Buildbucket for the build status
[21:01:21.582] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:21.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:200:0) after 1m0s
[21:02:21.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:200:0)
[21:02:21.636] Timer tick, asking Buildbucket for the build status
[21:02:21.780] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:21.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:201:0) after 1m0s
[21:03:21.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:201:0)
[21:03:21.807] Timer tick, asking Buildbucket for the build status
[21:03:21.861] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:21.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:202:0) after 1m0s
[21:04:21.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:202:0)
[21:04:21.903] Timer tick, asking Buildbucket for the build status
[21:04:21.974] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:21.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:203:0) after 1m0s
[21:05:22.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:203:0)
[21:05:22.067] Timer tick, asking Buildbucket for the build status
[21:05:22.129] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:22.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:204:0) after 1m0s
[21:06:22.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:204:0)
[21:06:22.227] Timer tick, asking Buildbucket for the build status
[21:06:22.401] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:22.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:205:0) after 1m0s
[21:07:22.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:205:0)
[21:07:22.424] Timer tick, asking Buildbucket for the build status
[21:07:22.528] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:22.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:206:0) after 1m0s
[21:08:22.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:206:0)
[21:08:22.558] Timer tick, asking Buildbucket for the build status
[21:08:22.854] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:22.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:207:0) after 1m0s
[21:09:22.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:207:0)
[21:09:22.889] Timer tick, asking Buildbucket for the build status
[21:09:23.018] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:23.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:208:0) after 1m0s
[21:10:23.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:208:0)
[21:10:23.122] Timer tick, asking Buildbucket for the build status
[21:10:23.217] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:23.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:209:0) after 1m0s
[21:11:23.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:209:0)
[21:11:23.245] Timer tick, asking Buildbucket for the build status
[21:11:23.350] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:23.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:210:0) after 1m0s
[21:12:23.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:210:0)
[21:12:23.380] Timer tick, asking Buildbucket for the build status
[21:12:23.419] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:23.419] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:211:0) after 1m0s
[21:13:23.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:211:0)
[21:13:23.447] Timer tick, asking Buildbucket for the build status
[21:13:23.485] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:23.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:212:0) after 1m0s
[21:14:23.522] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:212:0)
[21:14:23.522] Timer tick, asking Buildbucket for the build status
[21:14:26.050] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:26.050] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:213:0) after 1m0s
[21:15:26.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:213:0)
[21:15:26.077] Timer tick, asking Buildbucket for the build status
[21:15:26.119] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:26.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:214:0) after 1m0s
[21:16:26.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:214:0)
[21:16:26.165] Timer tick, asking Buildbucket for the build status
[21:16:26.239] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:26.239] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:215:0) after 1m0s
[21:17:26.266] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:215:0)
[21:17:26.266] Timer tick, asking Buildbucket for the build status
[21:17:26.548] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:26.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:216:0) after 1m0s
[21:18:26.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:216:0)
[21:18:26.576] Timer tick, asking Buildbucket for the build status
[21:18:26.668] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:26.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:217:0) after 1m0s
[21:19:26.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:217:0)
[21:19:26.718] Timer tick, asking Buildbucket for the build status
[21:19:27.086] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:27.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:218:0) after 1m0s
[21:20:27.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:218:0)
[21:20:27.111] Timer tick, asking Buildbucket for the build status
[21:20:27.207] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:27.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:219:0) after 1m0s
[21:21:27.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:219:0)
[21:21:27.233] Timer tick, asking Buildbucket for the build status
[21:21:27.282] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:27.282] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:220:0) after 1m0s
[21:22:27.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:220:0)
[21:22:27.315] Timer tick, asking Buildbucket for the build status
[21:22:27.576] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:27.576] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:221:0) after 1m0s
[21:23:27.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:221:0)
[21:23:27.607] Timer tick, asking Buildbucket for the build status
[21:23:27.682] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:222:0) after 1m0s
[21:24:27.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:222:0)
[21:24:27.709] Timer tick, asking Buildbucket for the build status
[21:24:27.773] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:27.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:223:0) after 1m0s
[21:25:27.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:223:0)
[21:25:27.801] Timer tick, asking Buildbucket for the build status
[21:25:27.880] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:27.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:224:0) after 1m0s
[21:26:28.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:224:0)
[21:26:28.037] Timer tick, asking Buildbucket for the build status
[21:26:33.856] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:33.856] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:225:0) after 1m0s
[21:27:33.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:225:0)
[21:27:33.887] Timer tick, asking Buildbucket for the build status
[21:27:33.951] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:33.951] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:226:0) after 1m0s
[21:28:34.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:226:0)
[21:28:34.017] Timer tick, asking Buildbucket for the build status
[21:28:34.247] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:34.247] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:227:0) after 1m0s
[21:29:34.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:227:0)
[21:29:34.323] Timer tick, asking Buildbucket for the build status
[21:29:34.423] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:34.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:228:0) after 1m0s
[21:30:34.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:228:0)
[21:30:34.452] Timer tick, asking Buildbucket for the build status
[21:30:34.524] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:34.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:229:0) after 1m0s
[21:31:34.552] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:229:0)
[21:31:34.552] Timer tick, asking Buildbucket for the build status
[21:31:34.592] Build 8939555411957804432: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:34.592] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9104985474281517600:230:0) after 1m0s
[21:31:55.543] Received PubSub notification, asking Buildbucket for the build status
[21:31:55.577] Build 8939555411957804432: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:31:55.577] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1532986314093480",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532972625733890",
"failure_reason": "BUILD_FAILURE",
"id": "8939555411957804432",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"cdf541470ddd2b2060608345a50e36c5f6b51d5f\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"ui\": {\"info\": \"Failure compare_build_artifacts\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"failure\": {\"failure\": {\"step\": \"compare_build_artifacts\"}, \"humanReason\": \"Step('compare_build_artifacts') failed with return_code 1\"}}, \"recipeExitCode\": {\"value\": 1}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8939555411957804432/+/annotations\"}, \"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3704-de2166f\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"fa95e2a7489d9efe3f8dd770c204b4d968eb9b02\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"cdf541470ddd2b2060608345a50e36c5f6b51d5f\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24141}\", \"$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@{#579081}\", \"branch\": \"refs/heads/master\", \"revision\": \"cdf541470ddd2b2060608345a50e36c5f6b51d5f\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"1bd66642c37083156c625578130dbed13f5fb32c\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"e452382a61a185577d561cc7807b437f4db32d90\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1532972625733890, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9104985474281517600\", \"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\": \"8939555411957804432\"}}, \"got_v8_revision\": \"5e5144a59f3800bbf1a93f7d356606514b419e1f\", \"got_v8_revision_cp\": \"refs/heads/7.0.94@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9611, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1532972751762730",
"status": "COMPLETED",
"status_changed_ts": "1532986314988590",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9611",
"builder:Windows deterministic",
"buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9104985474281517600",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/9611",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939555411957804432",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1843d7ecb7176e182855328359db08c38323a012",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cdf541470ddd2b2060608345a50e36c5f6b51d5f",
"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/8939555411957804432/+/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:9104985474281517600",
"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:b8825e1369b8060da18e1f3e340afb3fc7c3cd54",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3f051b79411b6710",
"user_agent:luci-scheduler"
],
"updated_ts": "1532986314990090",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9611",
"utcnow_ts": "1532986315566540"
}
}
[21:31:55.577] Invocation finished in 3h48m11.444267213s with status FAILED