[00:00:46.254] New invocation is queued and will start shortly
[00:00:47.490] Starting the invocation (attempt 1)
[00:00:47.522] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:00:47.522] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:00:47.523] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9105052350250777280",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"d07b639cf458488bf701bd5d93801026cee928d6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9105052350250777280",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/d07b639cf458488bf701bd5d93801026cee928d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6",
"gitiles_ref:refs/heads/master"
]
}
[00:00:48.561] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532908847589620",
"id": "8939622288188466704",
"lease_expiration_ts": "1533052848157690",
"lease_key": "1970630448",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d07b639cf458488bf701bd5d93801026cee928d6\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1532908848337810",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9606",
"builder:Windows deterministic",
"buildset:commit/git/d07b639cf458488bf701bd5d93801026cee928d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9105052350250777280",
"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/9606",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939622288188466704",
"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/d07b639cf458488bf701bd5d93801026cee928d6",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6",
"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/8939622288188466704/+/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:9105052350250777280",
"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:3f014e4b87f9e210",
"user_agent:luci-scheduler"
],
"updated_ts": "1532908848337920",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9606",
"utcnow_ts": "1532908848549880"
}
}
[00:00:48.561] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9606
[00:00:48.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:2:0) after 1m0s
[00:01:48.577] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:2:0)
[00:01:48.577] Timer tick, asking Buildbucket for the build status
[00:01:48.637] Build 8939622288188466704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:48.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:3:0) after 1m0s
[00:02:48.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:3:0)
[00:02:48.657] Timer tick, asking Buildbucket for the build status
[00:02:48.740] Build 8939622288188466704: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:48.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:4:0) after 1m0s
[00:02:57.148] Received PubSub notification, asking Buildbucket for the build status
[00:02:57.222] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:48.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:4:0)
[00:03:48.764] Timer tick, asking Buildbucket for the build status
[00:03:48.828] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:48.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:6:0) after 1m0s
[00:04:48.845] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:6:0)
[00:04:48.845] Timer tick, asking Buildbucket for the build status
[00:04:48.907] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:48.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:7:0) after 1m0s
[00:05:48.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:7:0)
[00:05:48.927] Timer tick, asking Buildbucket for the build status
[00:05:49.016] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:49.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:8:0) after 1m0s
[00:06:49.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:8:0)
[00:06:49.036] Timer tick, asking Buildbucket for the build status
[00:06:49.108] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:49.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:9:0) after 1m0s
[00:07:49.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:9:0)
[00:07:49.173] Timer tick, asking Buildbucket for the build status
[00:07:49.306] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:49.306] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:10:0) after 1m0s
[00:08:49.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:10:0)
[00:08:49.369] Timer tick, asking Buildbucket for the build status
[00:08:49.444] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:49.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:11:0) after 1m0s
[00:09:49.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:11:0)
[00:09:49.469] Timer tick, asking Buildbucket for the build status
[00:09:49.542] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:49.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:12:0) after 1m0s
[00:10:49.557] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:12:0)
[00:10:49.557] Timer tick, asking Buildbucket for the build status
[00:10:49.621] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:49.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:13:0) after 1m0s
[00:11:49.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:13:0)
[00:11:49.643] Timer tick, asking Buildbucket for the build status
[00:11:49.731] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:49.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:14:0) after 1m0s
[00:12:49.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:14:0)
[00:12:49.773] Timer tick, asking Buildbucket for the build status
[00:12:49.831] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:49.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:15:0) after 1m0s
[00:13:49.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:15:0)
[00:13:49.852] Timer tick, asking Buildbucket for the build status
[00:13:50.057] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:50.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:16:0) after 1m0s
[00:14:50.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:16:0)
[00:14:50.076] Timer tick, asking Buildbucket for the build status
[00:14:50.193] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:50.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:17:0) after 1m0s
[00:15:50.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:17:0)
[00:15:50.213] Timer tick, asking Buildbucket for the build status
[00:15:50.316] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:18:0) after 1m0s
[00:16:50.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:18:0)
[00:16:50.331] Timer tick, asking Buildbucket for the build status
[00:16:50.594] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:50.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:19:0) after 1m0s
[00:17:50.614] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:19:0)
[00:17:50.614] Timer tick, asking Buildbucket for the build status
[00:17:50.672] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:50.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:20:0) after 1m0s
[00:18:50.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:20:0)
[00:18:50.689] Timer tick, asking Buildbucket for the build status
[00:18:51.093] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:21:0) after 1m0s
[00:19:51.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:21:0)
[00:19:51.115] Timer tick, asking Buildbucket for the build status
[00:19:51.302] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:22:0) after 1m0s
[00:20:51.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:22:0)
[00:20:51.396] Timer tick, asking Buildbucket for the build status
[00:20:51.450] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:51.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:23:0) after 1m0s
[00:21:51.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:23:0)
[00:21:51.470] Timer tick, asking Buildbucket for the build status
[00:21:51.525] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:51.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:24:0) after 1m0s
[00:22:51.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:24:0)
[00:22:51.542] Timer tick, asking Buildbucket for the build status
[00:22:51.746] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:51.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:25:0) after 1m0s
[00:23:51.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:25:0)
[00:23:51.765] Timer tick, asking Buildbucket for the build status
[00:23:51.817] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:51.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:26:0) after 1m0s
[00:24:51.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:26:0)
[00:24:51.897] Timer tick, asking Buildbucket for the build status
[00:24:52.057] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:52.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:27:0) after 1m0s
[00:25:52.118] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:27:0)
[00:25:52.118] Timer tick, asking Buildbucket for the build status
[00:25:52.252] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:52.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:28:0) after 1m0s
[00:26:52.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:28:0)
[00:26:52.268] Timer tick, asking Buildbucket for the build status
[00:26:52.460] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:52.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:29:0) after 1m0s
[00:27:52.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:29:0)
[00:27:52.511] Timer tick, asking Buildbucket for the build status
[00:27:52.702] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:52.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:30:0) after 1m0s
[00:28:52.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:30:0)
[00:28:52.724] Timer tick, asking Buildbucket for the build status
[00:28:52.929] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:52.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:31:0) after 1m0s
[00:29:52.952] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:31:0)
[00:29:52.952] Timer tick, asking Buildbucket for the build status
[00:29:53.031] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:53.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:32:0) after 1m0s
[00:30:53.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:32:0)
[00:30:53.049] Timer tick, asking Buildbucket for the build status
[00:30:53.088] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:53.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:33:0) after 1m0s
[00:31:53.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:33:0)
[00:31:53.106] Timer tick, asking Buildbucket for the build status
[00:31:53.169] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:53.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:34:0) after 1m0s
[00:32:53.189] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:34:0)
[00:32:53.189] Timer tick, asking Buildbucket for the build status
[00:32:53.254] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:53.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:35:0) after 1m0s
[00:33:53.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:35:0)
[00:33:53.276] Timer tick, asking Buildbucket for the build status
[00:33:53.410] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:36:0) after 1m0s
[00:34:53.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:36:0)
[00:34:53.436] Timer tick, asking Buildbucket for the build status
[00:34:53.498] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:53.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:37:0) after 1m0s
[00:35:53.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:37:0)
[00:35:53.519] Timer tick, asking Buildbucket for the build status
[00:35:53.560] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:53.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:38:0) after 1m0s
[00:36:53.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:38:0)
[00:36:53.699] Timer tick, asking Buildbucket for the build status
[00:36:54.041] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:54.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:39:0) after 1m0s
[00:37:54.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:39:0)
[00:37:54.134] Timer tick, asking Buildbucket for the build status
[00:37:54.243] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:54.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:40:0) after 1m0s
[00:38:54.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:40:0)
[00:38:54.262] Timer tick, asking Buildbucket for the build status
[00:38:54.348] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:54.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:41:0) after 1m0s
[00:39:54.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:41:0)
[00:39:54.369] Timer tick, asking Buildbucket for the build status
[00:39:54.448] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:54.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:42:0) after 1m0s
[00:40:54.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:42:0)
[00:40:54.483] Timer tick, asking Buildbucket for the build status
[00:40:54.887] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:43:0) after 1m0s
[00:41:54.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:43:0)
[00:41:54.909] Timer tick, asking Buildbucket for the build status
[00:41:54.968] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:54.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:44:0) after 1m0s
[00:42:55.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:44:0)
[00:42:55.037] Timer tick, asking Buildbucket for the build status
[00:42:55.209] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:55.209] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:45:0) after 1m0s
[00:43:55.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:45:0)
[00:43:55.231] Timer tick, asking Buildbucket for the build status
[00:43:55.369] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:55.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:46:0) after 1m0s
[00:44:55.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:46:0)
[00:44:55.405] Timer tick, asking Buildbucket for the build status
[00:44:55.527] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:55.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:47:0) after 1m0s
[00:45:55.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:47:0)
[00:45:55.572] Timer tick, asking Buildbucket for the build status
[00:45:55.613] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:55.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:48:0) after 1m0s
[00:46:55.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:48:0)
[00:46:55.633] Timer tick, asking Buildbucket for the build status
[00:46:56.053] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:56.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:49:0) after 1m0s
[00:47:56.090] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:49:0)
[00:47:56.090] Timer tick, asking Buildbucket for the build status
[00:47:56.125] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:56.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:50:0) after 1m0s
[00:48:56.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:50:0)
[00:48:56.145] Timer tick, asking Buildbucket for the build status
[00:48:56.547] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:56.547] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:51:0) after 1m0s
[00:49:56.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:51:0)
[00:49:56.567] Timer tick, asking Buildbucket for the build status
[00:49:56.624] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:56.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:52:0) after 1m0s
[00:50:56.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:52:0)
[00:50:56.726] Timer tick, asking Buildbucket for the build status
[00:50:56.766] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:56.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:53:0) after 1m0s
[00:51:56.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:53:0)
[00:51:56.885] Timer tick, asking Buildbucket for the build status
[00:51:56.967] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:56.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:54:0) after 1m0s
[00:52:56.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:54:0)
[00:52:56.986] Timer tick, asking Buildbucket for the build status
[00:52:57.307] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:57.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:55:0) after 1m0s
[00:53:57.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:55:0)
[00:53:57.331] Timer tick, asking Buildbucket for the build status
[00:53:57.449] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:57.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:56:0) after 1m0s
[00:54:57.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:56:0)
[00:54:57.469] Timer tick, asking Buildbucket for the build status
[00:54:57.595] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:57:0) after 1m0s
[00:55:57.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:57:0)
[00:55:57.617] Timer tick, asking Buildbucket for the build status
[00:55:57.681] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:57.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:58:0) after 1m0s
[00:56:57.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:58:0)
[00:56:57.780] Timer tick, asking Buildbucket for the build status
[00:56:57.817] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:57.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:59:0) after 1m0s
[00:57:57.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:59:0)
[00:57:57.836] Timer tick, asking Buildbucket for the build status
[00:57:57.896] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:57.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:60:0) after 1m0s
[00:58:57.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:60:0)
[00:58:57.916] Timer tick, asking Buildbucket for the build status
[00:58:58.043] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:58.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:61:0) after 1m0s
[00:59:58.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:61:0)
[00:59:58.073] Timer tick, asking Buildbucket for the build status
[00:59:58.210] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:58.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:62:0) after 1m0s
[01:00:58.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:62:0)
[01:00:58.322] Timer tick, asking Buildbucket for the build status
[01:00:58.401] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:58.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:63:0) after 1m0s
[01:01:58.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:63:0)
[01:01:58.424] Timer tick, asking Buildbucket for the build status
[01:01:58.530] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:58.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:64:0) after 1m0s
[01:02:58.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:64:0)
[01:02:58.553] Timer tick, asking Buildbucket for the build status
[01:02:58.606] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:58.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:65:0) after 1m0s
[01:03:58.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:65:0)
[01:03:58.630] Timer tick, asking Buildbucket for the build status
[01:03:58.855] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:58.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:66:0) after 1m0s
[01:04:58.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:66:0)
[01:04:58.926] Timer tick, asking Buildbucket for the build status
[01:04:58.980] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:58.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:67:0) after 1m0s
[01:05:59.000] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:67:0)
[01:05:59.000] Timer tick, asking Buildbucket for the build status
[01:05:59.107] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:59.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:68:0) after 1m0s
[01:06:59.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:68:0)
[01:06:59.139] Timer tick, asking Buildbucket for the build status
[01:06:59.349] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:59.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:69:0) after 1m0s
[01:07:59.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:69:0)
[01:07:59.369] Timer tick, asking Buildbucket for the build status
[01:07:59.441] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:59.441] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:70:0) after 1m0s
[01:08:59.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:70:0)
[01:08:59.497] Timer tick, asking Buildbucket for the build status
[01:08:59.540] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:59.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:71:0) after 1m0s
[01:09:59.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:71:0)
[01:09:59.560] Timer tick, asking Buildbucket for the build status
[01:09:59.623] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:59.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:72:0) after 1m0s
[01:10:59.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:72:0)
[01:10:59.641] Timer tick, asking Buildbucket for the build status
[01:11:00.169] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:00.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:73:0) after 1m0s
[01:12:00.263] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:73:0)
[01:12:00.263] Timer tick, asking Buildbucket for the build status
[01:12:00.338] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:00.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:74:0) after 1m0s
[01:13:00.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:74:0)
[01:13:00.397] Timer tick, asking Buildbucket for the build status
[01:13:00.494] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:00.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:75:0) after 1m0s
[01:14:00.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:75:0)
[01:14:00.512] Timer tick, asking Buildbucket for the build status
[01:14:00.564] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:00.564] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:76:0) after 1m0s
[01:15:00.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:76:0)
[01:15:00.588] Timer tick, asking Buildbucket for the build status
[01:15:00.993] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:00.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:77:0) after 1m0s
[01:16:01.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:77:0)
[01:16:01.101] Timer tick, asking Buildbucket for the build status
[01:16:01.240] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:01.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:78:0) after 1m0s
[01:17:01.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:78:0)
[01:17:01.312] Timer tick, asking Buildbucket for the build status
[01:17:01.403] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:01.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:79:0) after 1m0s
[01:18:01.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:79:0)
[01:18:01.511] Timer tick, asking Buildbucket for the build status
[01:18:01.610] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:01.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:80:0) after 1m0s
[01:19:01.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:80:0)
[01:19:01.630] Timer tick, asking Buildbucket for the build status
[01:19:01.749] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:01.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:81:0) after 1m0s
[01:20:01.769] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:81:0)
[01:20:01.769] Timer tick, asking Buildbucket for the build status
[01:20:01.890] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:01.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:82:0) after 1m0s
[01:21:01.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:82:0)
[01:21:01.910] Timer tick, asking Buildbucket for the build status
[01:21:02.047] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:02.047] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:83:0) after 1m0s
[01:22:02.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:83:0)
[01:22:02.071] Timer tick, asking Buildbucket for the build status
[01:22:02.132] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:02.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:84:0) after 1m0s
[01:23:02.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:84:0)
[01:23:02.212] Timer tick, asking Buildbucket for the build status
[01:23:06.958] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:06.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:85:0) after 1m0s
[01:24:07.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:85:0)
[01:24:07.012] Timer tick, asking Buildbucket for the build status
[01:24:07.081] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:07.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:86:0) after 1m0s
[01:25:07.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:86:0)
[01:25:07.109] Timer tick, asking Buildbucket for the build status
[01:25:07.152] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:07.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:87:0) after 1m0s
[01:26:07.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:87:0)
[01:26:07.177] Timer tick, asking Buildbucket for the build status
[01:26:07.214] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:07.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:88:0) after 1m0s
[01:27:07.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:88:0)
[01:27:07.237] Timer tick, asking Buildbucket for the build status
[01:27:07.295] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:07.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:89:0) after 1m0s
[01:28:07.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:89:0)
[01:28:07.327] Timer tick, asking Buildbucket for the build status
[01:28:07.459] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:07.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:90:0) after 1m0s
[01:29:07.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:90:0)
[01:29:07.480] Timer tick, asking Buildbucket for the build status
[01:29:07.625] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:07.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:91:0) after 1m0s
[01:30:07.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:91:0)
[01:30:07.660] Timer tick, asking Buildbucket for the build status
[01:30:07.819] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:07.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:92:0) after 1m0s
[01:31:07.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:92:0)
[01:31:07.852] Timer tick, asking Buildbucket for the build status
[01:31:07.944] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:07.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:93:0) after 1m0s
[01:32:07.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:93:0)
[01:32:07.965] Timer tick, asking Buildbucket for the build status
[01:32:08.003] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:08.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:94:0) after 1m0s
[01:33:08.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:94:0)
[01:33:08.024] Timer tick, asking Buildbucket for the build status
[01:33:08.170] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:08.170] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:95:0) after 1m0s
[01:34:08.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:95:0)
[01:34:08.197] Timer tick, asking Buildbucket for the build status
[01:34:08.247] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:08.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:96:0) after 1m0s
[01:35:08.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:96:0)
[01:35:08.267] Timer tick, asking Buildbucket for the build status
[01:35:08.400] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:08.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:97:0) after 1m0s
[01:36:08.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:97:0)
[01:36:08.507] Timer tick, asking Buildbucket for the build status
[01:36:08.657] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:08.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:98:0) after 1m0s
[01:37:08.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:98:0)
[01:37:08.679] Timer tick, asking Buildbucket for the build status
[01:37:08.721] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:08.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:99:0) after 1m0s
[01:38:08.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:99:0)
[01:38:08.743] Timer tick, asking Buildbucket for the build status
[01:38:08.782] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:08.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:100:0) after 1m0s
[01:39:08.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:100:0)
[01:39:08.812] Timer tick, asking Buildbucket for the build status
[01:39:08.884] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:08.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:101:0) after 1m0s
[01:40:08.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:101:0)
[01:40:08.967] Timer tick, asking Buildbucket for the build status
[01:40:09.036] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:09.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:102:0) after 1m0s
[01:41:09.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:102:0)
[01:41:09.061] Timer tick, asking Buildbucket for the build status
[01:41:09.126] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:09.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:103:0) after 1m0s
[01:42:09.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:103:0)
[01:42:09.154] Timer tick, asking Buildbucket for the build status
[01:42:09.245] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:09.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:104:0) after 1m0s
[01:43:09.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:104:0)
[01:43:09.271] Timer tick, asking Buildbucket for the build status
[01:43:09.429] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:09.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:105:0) after 1m0s
[01:44:09.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:105:0)
[01:44:09.450] Timer tick, asking Buildbucket for the build status
[01:44:09.516] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:09.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:106:0) after 1m0s
[01:45:09.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:106:0)
[01:45:09.538] Timer tick, asking Buildbucket for the build status
[01:45:09.629] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:09.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:107:0) after 1m0s
[01:46:09.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:107:0)
[01:46:09.651] Timer tick, asking Buildbucket for the build status
[01:46:09.730] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:09.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:108:0) after 1m0s
[01:47:09.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:108:0)
[01:47:09.752] Timer tick, asking Buildbucket for the build status
[01:47:09.790] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:09.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:109:0) after 1m0s
[01:48:09.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:109:0)
[01:48:09.813] Timer tick, asking Buildbucket for the build status
[01:48:09.870] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:09.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:110:0) after 1m0s
[01:49:09.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:110:0)
[01:49:09.915] Timer tick, asking Buildbucket for the build status
[01:49:09.981] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:09.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:111:0) after 1m0s
[01:50:10.002] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:111:0)
[01:50:10.002] Timer tick, asking Buildbucket for the build status
[01:50:10.053] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:10.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:112:0) after 1m0s
[01:51:10.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:112:0)
[01:51:10.074] Timer tick, asking Buildbucket for the build status
[01:51:10.264] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:10.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:113:0) after 1m0s
[01:52:10.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:113:0)
[01:52:10.376] Timer tick, asking Buildbucket for the build status
[01:52:10.500] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:10.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:114:0) after 1m0s
[01:53:10.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:114:0)
[01:53:10.583] Timer tick, asking Buildbucket for the build status
[01:53:10.636] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:10.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:115:0) after 1m0s
[01:54:10.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:115:0)
[01:54:10.670] Timer tick, asking Buildbucket for the build status
[01:54:10.827] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:10.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:116:0) after 1m0s
[01:55:10.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:116:0)
[01:55:10.846] Timer tick, asking Buildbucket for the build status
[01:55:11.092] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:11.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:117:0) after 1m0s
[01:56:11.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:117:0)
[01:56:11.117] Timer tick, asking Buildbucket for the build status
[01:56:11.166] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:11.166] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:118:0) after 1m0s
[01:57:11.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:118:0)
[01:57:11.201] Timer tick, asking Buildbucket for the build status
[01:57:11.354] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:11.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:119:0) after 1m0s
[01:58:11.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:119:0)
[01:58:11.390] Timer tick, asking Buildbucket for the build status
[01:58:11.510] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:11.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:120:0) after 1m0s
[01:59:11.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:120:0)
[01:59:11.541] Timer tick, asking Buildbucket for the build status
[01:59:11.644] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:11.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:121:0) after 1m0s
[02:00:11.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:121:0)
[02:00:11.675] Timer tick, asking Buildbucket for the build status
[02:00:11.865] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:11.865] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:122:0) after 1m0s
[02:01:11.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:122:0)
[02:01:11.888] Timer tick, asking Buildbucket for the build status
[02:01:11.954] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:11.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:123:0) after 1m0s
[02:02:11.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:123:0)
[02:02:11.976] Timer tick, asking Buildbucket for the build status
[02:02:12.031] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:12.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:124:0) after 1m0s
[02:03:12.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:124:0)
[02:03:12.125] Timer tick, asking Buildbucket for the build status
[02:03:12.316] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:12.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:125:0) after 1m0s
[02:04:12.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:125:0)
[02:04:12.339] Timer tick, asking Buildbucket for the build status
[02:04:12.418] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:12.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:126:0) after 1m0s
[02:05:12.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:126:0)
[02:05:12.446] Timer tick, asking Buildbucket for the build status
[02:05:12.502] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:12.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:127:0) after 1m0s
[02:06:12.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:127:0)
[02:06:12.556] Timer tick, asking Buildbucket for the build status
[02:06:12.614] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:128:0) after 1m0s
[02:07:12.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:128:0)
[02:07:12.638] Timer tick, asking Buildbucket for the build status
[02:07:12.682] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:12.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:129:0) after 1m0s
[02:08:12.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:129:0)
[02:08:12.705] Timer tick, asking Buildbucket for the build status
[02:08:12.757] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:12.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:130:0) after 1m0s
[02:09:12.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:130:0)
[02:09:12.782] Timer tick, asking Buildbucket for the build status
[02:09:12.864] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:12.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:131:0) after 1m0s
[02:10:12.902] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:131:0)
[02:10:12.902] Timer tick, asking Buildbucket for the build status
[02:10:12.989] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:12.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:132:0) after 1m0s
[02:11:13.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:132:0)
[02:11:13.108] Timer tick, asking Buildbucket for the build status
[02:11:13.189] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:13.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:133:0) after 1m0s
[02:12:13.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:133:0)
[02:12:13.223] Timer tick, asking Buildbucket for the build status
[02:12:13.298] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:13.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:134:0) after 1m0s
[02:13:13.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:134:0)
[02:13:13.322] Timer tick, asking Buildbucket for the build status
[02:13:13.447] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:13.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:135:0) after 1m0s
[02:14:13.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:135:0)
[02:14:13.474] Timer tick, asking Buildbucket for the build status
[02:14:13.831] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:13.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:136:0) after 1m0s
[02:15:13.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:136:0)
[02:15:13.854] Timer tick, asking Buildbucket for the build status
[02:15:13.971] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:13.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:137:0) after 1m0s
[02:16:13.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:137:0)
[02:16:13.992] Timer tick, asking Buildbucket for the build status
[02:16:14.055] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:14.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:138:0) after 1m0s
[02:17:14.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:138:0)
[02:17:14.081] Timer tick, asking Buildbucket for the build status
[02:17:14.163] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:14.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:139:0) after 1m0s
[02:18:14.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:139:0)
[02:18:14.185] Timer tick, asking Buildbucket for the build status
[02:18:14.227] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:14.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:140:0) after 1m0s
[02:19:14.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:140:0)
[02:19:14.250] Timer tick, asking Buildbucket for the build status
[02:19:14.416] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:14.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:141:0) after 1m0s
[02:20:14.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:141:0)
[02:20:14.452] Timer tick, asking Buildbucket for the build status
[02:20:14.517] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:14.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:142:0) after 1m0s
[02:21:14.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:142:0)
[02:21:14.541] Timer tick, asking Buildbucket for the build status
[02:21:14.663] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:14.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:143:0) after 1m0s
[02:22:14.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:143:0)
[02:22:14.684] Timer tick, asking Buildbucket for the build status
[02:22:14.751] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:14.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:144:0) after 1m0s
[02:23:14.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:144:0)
[02:23:14.778] Timer tick, asking Buildbucket for the build status
[02:23:14.819] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:14.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:145:0) after 1m0s
[02:24:14.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:145:0)
[02:24:14.899] Timer tick, asking Buildbucket for the build status
[02:24:15.008] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:15.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:146:0) after 1m0s
[02:25:15.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:146:0)
[02:25:15.034] Timer tick, asking Buildbucket for the build status
[02:25:15.217] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:15.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:147:0) after 1m0s
[02:26:15.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:147:0)
[02:26:15.242] Timer tick, asking Buildbucket for the build status
[02:26:15.354] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:15.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:148:0) after 1m0s
[02:27:15.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:148:0)
[02:27:15.424] Timer tick, asking Buildbucket for the build status
[02:27:15.475] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:15.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:149:0) after 1m0s
[02:28:15.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:149:0)
[02:28:15.503] Timer tick, asking Buildbucket for the build status
[02:28:15.773] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:15.773] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:150:0) after 1m0s
[02:29:15.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:150:0)
[02:29:15.872] Timer tick, asking Buildbucket for the build status
[02:29:15.921] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:15.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:151:0) after 1m0s
[02:30:16.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:151:0)
[02:30:16.075] Timer tick, asking Buildbucket for the build status
[02:30:16.118] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:16.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:152:0) after 1m0s
[02:31:16.163] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:152:0)
[02:31:16.163] Timer tick, asking Buildbucket for the build status
[02:31:16.261] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:16.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:153:0) after 1m0s
[02:32:16.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:153:0)
[02:32:16.295] Timer tick, asking Buildbucket for the build status
[02:32:16.409] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:16.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:154:0) after 1m0s
[02:33:16.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:154:0)
[02:33:16.431] Timer tick, asking Buildbucket for the build status
[02:33:16.628] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:16.628] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:155:0) after 1m0s
[02:34:16.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:155:0)
[02:34:16.652] Timer tick, asking Buildbucket for the build status
[02:34:16.785] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:16.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:156:0) after 1m0s
[02:35:16.809] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:156:0)
[02:35:16.809] Timer tick, asking Buildbucket for the build status
[02:35:16.843] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:16.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:157:0) after 1m0s
[02:36:16.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:157:0)
[02:36:16.894] Timer tick, asking Buildbucket for the build status
[02:36:16.980] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:16.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:158:0) after 1m0s
[02:37:17.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:158:0)
[02:37:17.021] Timer tick, asking Buildbucket for the build status
[02:37:17.065] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:17.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:159:0) after 1m0s
[02:38:17.090] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:159:0)
[02:38:17.090] Timer tick, asking Buildbucket for the build status
[02:38:17.151] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:17.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:160:0) after 1m0s
[02:39:17.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:160:0)
[02:39:17.174] Timer tick, asking Buildbucket for the build status
[02:39:17.214] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:17.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:161:0) after 1m0s
[02:40:17.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:161:0)
[02:40:17.298] Timer tick, asking Buildbucket for the build status
[02:40:17.366] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:17.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:162:0) after 1m0s
[02:41:17.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:162:0)
[02:41:17.387] Timer tick, asking Buildbucket for the build status
[02:41:17.473] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:163:0) after 1m0s
[02:42:17.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:163:0)
[02:42:17.515] Timer tick, asking Buildbucket for the build status
[02:42:17.568] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:17.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:164:0) after 1m0s
[02:43:17.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:164:0)
[02:43:17.603] Timer tick, asking Buildbucket for the build status
[02:43:17.673] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:17.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:165:0) after 1m0s
[02:44:17.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:165:0)
[02:44:17.699] Timer tick, asking Buildbucket for the build status
[02:44:17.747] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:17.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:166:0) after 1m0s
[02:45:17.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:166:0)
[02:45:17.771] Timer tick, asking Buildbucket for the build status
[02:45:17.887] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:17.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:167:0) after 1m0s
[02:46:17.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:167:0)
[02:46:17.917] Timer tick, asking Buildbucket for the build status
[02:46:17.975] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:17.975] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:168:0) after 1m0s
[02:47:17.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:168:0)
[02:47:17.999] Timer tick, asking Buildbucket for the build status
[02:47:18.065] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:18.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:169:0) after 1m0s
[02:48:18.093] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:169:0)
[02:48:18.093] Timer tick, asking Buildbucket for the build status
[02:48:18.132] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:18.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:170:0) after 1m0s
[02:49:18.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:170:0)
[02:49:18.156] Timer tick, asking Buildbucket for the build status
[02:49:18.417] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:18.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:171:0) after 1m0s
[02:50:18.436] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:171:0)
[02:50:18.436] Timer tick, asking Buildbucket for the build status
[02:50:18.546] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:18.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:172:0) after 1m0s
[02:51:18.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:172:0)
[02:51:18.730] Timer tick, asking Buildbucket for the build status
[02:51:18.903] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:18.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:173:0) after 1m0s
[02:52:18.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:173:0)
[02:52:18.928] Timer tick, asking Buildbucket for the build status
[02:52:19.070] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:19.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:174:0) after 1m0s
[02:53:19.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:174:0)
[02:53:19.261] Timer tick, asking Buildbucket for the build status
[02:53:19.290] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:19.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:175:0) after 1m0s
[02:54:19.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:175:0)
[02:54:19.574] Timer tick, asking Buildbucket for the build status
[02:54:19.619] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:19.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:176:0) after 1m0s
[02:55:19.836] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:176:0)
[02:55:19.836] Timer tick, asking Buildbucket for the build status
[02:55:19.958] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:19.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:177:0) after 1m0s
[02:56:20.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:177:0)
[02:56:20.135] Timer tick, asking Buildbucket for the build status
[02:56:20.255] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:20.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:178:0) after 1m0s
[02:57:20.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:178:0)
[02:57:20.544] Timer tick, asking Buildbucket for the build status
[02:57:20.691] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:20.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:179:0) after 1m0s
[02:58:20.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:179:0)
[02:58:20.820] Timer tick, asking Buildbucket for the build status
[02:58:20.945] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:20.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:180:0) after 1m0s
[02:59:21.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:180:0)
[02:59:21.227] Timer tick, asking Buildbucket for the build status
[02:59:21.286] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:21.286] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:181:0) after 1m0s
[03:00:21.396] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:181:0)
[03:00:21.396] Timer tick, asking Buildbucket for the build status
[03:00:21.545] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:21.545] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:182:0) after 1m0s
[03:01:21.588] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:182:0)
[03:01:21.588] Timer tick, asking Buildbucket for the build status
[03:01:21.725] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:21.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:183:0) after 1m0s
[03:02:21.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:183:0)
[03:02:21.748] Timer tick, asking Buildbucket for the build status
[03:02:21.886] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:21.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:184:0) after 1m0s
[03:03:21.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:184:0)
[03:03:21.912] Timer tick, asking Buildbucket for the build status
[03:03:22.252] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:22.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:185:0) after 1m0s
[03:04:22.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:185:0)
[03:04:22.347] Timer tick, asking Buildbucket for the build status
[03:04:22.438] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:22.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:186:0) after 1m0s
[03:05:22.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:186:0)
[03:05:22.679] Timer tick, asking Buildbucket for the build status
[03:05:22.910] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:22.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:187:0) after 1m0s
[03:06:22.971] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:187:0)
[03:06:22.971] Timer tick, asking Buildbucket for the build status
[03:06:23.032] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:23.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:188:0) after 1m0s
[03:07:23.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:188:0)
[03:07:23.240] Timer tick, asking Buildbucket for the build status
[03:07:23.281] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:23.281] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:189:0) after 1m0s
[03:08:23.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:189:0)
[03:08:23.623] Timer tick, asking Buildbucket for the build status
[03:08:23.674] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:23.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:190:0) after 1m0s
[03:09:23.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:190:0)
[03:09:23.918] Timer tick, asking Buildbucket for the build status
[03:09:23.992] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:23.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:191:0) after 1m0s
[03:10:24.013] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:191:0)
[03:10:24.013] Timer tick, asking Buildbucket for the build status
[03:10:24.120] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:24.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:192:0) after 1m0s
[03:11:24.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:192:0)
[03:11:24.212] Timer tick, asking Buildbucket for the build status
[03:11:24.297] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:24.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:193:0) after 1m0s
[03:12:24.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:193:0)
[03:12:24.529] Timer tick, asking Buildbucket for the build status
[03:12:24.703] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:24.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:194:0) after 1m0s
[03:13:24.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:194:0)
[03:13:24.870] Timer tick, asking Buildbucket for the build status
[03:13:24.954] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:24.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:195:0) after 1m0s
[03:14:25.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:195:0)
[03:14:25.242] Timer tick, asking Buildbucket for the build status
[03:14:25.292] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:25.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:196:0) after 1m0s
[03:15:25.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:196:0)
[03:15:25.525] Timer tick, asking Buildbucket for the build status
[03:15:25.606] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:25.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:197:0) after 1m0s
[03:16:25.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:197:0)
[03:16:25.648] Timer tick, asking Buildbucket for the build status
[03:16:25.972] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:25.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:198:0) after 1m0s
[03:17:26.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:198:0)
[03:17:26.004] Timer tick, asking Buildbucket for the build status
[03:17:26.059] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:26.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:199:0) after 1m0s
[03:18:26.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:199:0)
[03:18:26.085] Timer tick, asking Buildbucket for the build status
[03:18:26.156] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:26.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:200:0) after 1m0s
[03:19:26.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:200:0)
[03:19:26.185] Timer tick, asking Buildbucket for the build status
[03:19:26.308] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:26.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:201:0) after 1m0s
[03:20:26.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:201:0)
[03:20:26.338] Timer tick, asking Buildbucket for the build status
[03:20:26.460] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:26.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:202:0) after 1m0s
[03:21:26.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:202:0)
[03:21:26.492] Timer tick, asking Buildbucket for the build status
[03:21:26.538] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:26.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:203:0) after 1m0s
[03:22:26.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:203:0)
[03:22:26.631] Timer tick, asking Buildbucket for the build status
[03:22:27.220] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:27.220] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:204:0) after 1m0s
[03:23:27.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:204:0)
[03:23:27.246] Timer tick, asking Buildbucket for the build status
[03:23:27.296] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:27.296] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:205:0) after 1m0s
[03:24:27.326] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:205:0)
[03:24:27.326] Timer tick, asking Buildbucket for the build status
[03:24:27.373] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:27.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:206:0) after 1m0s
[03:25:27.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:206:0)
[03:25:27.399] Timer tick, asking Buildbucket for the build status
[03:25:27.633] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:27.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:207:0) after 1m0s
[03:26:27.696] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:207:0)
[03:26:27.696] Timer tick, asking Buildbucket for the build status
[03:26:27.765] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:27.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:208:0) after 1m0s
[03:27:27.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:208:0)
[03:27:27.817] Timer tick, asking Buildbucket for the build status
[03:27:27.902] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:27.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:209:0) after 1m0s
[03:28:28.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:209:0)
[03:28:28.121] Timer tick, asking Buildbucket for the build status
[03:28:28.179] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:28.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:210:0) after 1m0s
[03:29:28.532] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:210:0)
[03:29:28.532] Timer tick, asking Buildbucket for the build status
[03:29:28.604] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:28.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:211:0) after 1m0s
[03:30:28.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:211:0)
[03:30:28.862] Timer tick, asking Buildbucket for the build status
[03:30:29.088] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:29.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:212:0) after 1m0s
[03:31:29.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:212:0)
[03:31:29.152] Timer tick, asking Buildbucket for the build status
[03:31:29.309] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:29.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:213:0) after 1m0s
[03:32:29.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:213:0)
[03:32:29.618] Timer tick, asking Buildbucket for the build status
[03:32:29.745] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:29.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:214:0) after 1m0s
[03:33:29.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:214:0)
[03:33:29.911] Timer tick, asking Buildbucket for the build status
[03:33:30.452] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:30.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:215:0) after 1m0s
[03:34:30.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:215:0)
[03:34:30.545] Timer tick, asking Buildbucket for the build status
[03:34:30.655] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:30.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:216:0) after 1m0s
[03:35:31.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:216:0)
[03:35:31.036] Timer tick, asking Buildbucket for the build status
[03:35:31.243] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:31.243] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:217:0) after 1m0s
[03:36:31.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:217:0)
[03:36:31.399] Timer tick, asking Buildbucket for the build status
[03:36:31.483] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:31.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:218:0) after 1m0s
[03:37:31.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:218:0)
[03:37:31.640] Timer tick, asking Buildbucket for the build status
[03:37:31.753] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:31.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:219:0) after 1m0s
[03:38:31.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:219:0)
[03:38:31.977] Timer tick, asking Buildbucket for the build status
[03:38:32.034] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:32.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:220:0) after 1m0s
[03:39:32.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:220:0)
[03:39:32.066] Timer tick, asking Buildbucket for the build status
[03:39:32.159] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:32.159] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:221:0) after 1m0s
[03:40:32.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:221:0)
[03:40:32.192] Timer tick, asking Buildbucket for the build status
[03:40:32.313] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:32.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:222:0) after 1m0s
[03:41:32.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:222:0)
[03:41:32.439] Timer tick, asking Buildbucket for the build status
[03:41:32.497] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:32.497] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:223:0) after 1m0s
[03:42:32.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:223:0)
[03:42:32.709] Timer tick, asking Buildbucket for the build status
[03:42:32.836] Build 8939622288188466704: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:32.836] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9105052350250777280:224:0) after 1m0s
[03:43:08.972] Received PubSub notification, asking Buildbucket for the build status
[03:43:09.007] Build 8939622288188466704: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[03:43:09.007] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1532922187795790",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1532908847589620",
"failure_reason": "BUILD_FAILURE",
"id": "8939622288188466704",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"d07b639cf458488bf701bd5d93801026cee928d6\"}}",
"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/8939622288188466704/+/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\": \"d07b639cf458488bf701bd5d93801026cee928d6\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24139}\", \"$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@{#578955}\", \"branch\": \"refs/heads/master\", \"revision\": \"d07b639cf458488bf701bd5d93801026cee928d6\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"d1d8f9815d7692a2c0ebdd63d908fcc0e8ef6158\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"5b3b5cc126a7a0e0b45574c8f8aac24cd5f59e21\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1532908847589620, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/d07b639cf458488bf701bd5d93801026cee928d6\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9105052350250777280\", \"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\": \"8939622288188466704\"}}, \"got_v8_revision\": \"5279da5c66ef5cfacd2edc5c157a2cee4afcde2e\", \"got_v8_revision_cp\": \"refs/heads/7.0.85@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 9606, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"0dd5c6f980d22be96b728155249df2da355989d9\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1532908976129280",
"status": "COMPLETED",
"status_changed_ts": "1532922188493880",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/9606",
"builder:Windows deterministic",
"buildset:commit/git/d07b639cf458488bf701bd5d93801026cee928d6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9105052350250777280",
"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/9606",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8939622288188466704",
"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/d07b639cf458488bf701bd5d93801026cee928d6",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d07b639cf458488bf701bd5d93801026cee928d6",
"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/8939622288188466704/+/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:9105052350250777280",
"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:3f014e4b87f9e210",
"user_agent:luci-scheduler"
],
"updated_ts": "1532922188494980",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/9606",
"utcnow_ts": "1532922188995760"
}
}
[03:43:09.007] Invocation finished in 3h42m22.767774251s with status FAILED