[13:01:02.677] New invocation is queued and will start shortly
[13:01:03.928] Starting the invocation (attempt 1)
[13:01:03.959] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[13:01:03.959] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[13:01:03.959] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097121323598041488",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"92aa42c2a5abb0842a83e306e287eb4467b48f56\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097121323598041488",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"gitiles_ref:refs/heads/master"
]
}
[13:01:05.536] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540472464058956",
"id": "8931691261485839072",
"lease_expiration_ts": "1540591265251999",
"lease_key": "693886180",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"92aa42c2a5abb0842a83e306e287eb4467b48f56\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540472465419884",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10517",
"builder:Windows deterministic",
"buildset:commit/git/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097121323598041488",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10517",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931691261485839072",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8931691261485839072/+/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:9097121323598041488",
"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:d633426da4cba82a1896950c9ffa957dc80b54e5",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c421ed12961010",
"user_agent:luci-scheduler"
],
"updated_ts": "1540472465419976",
"url": "https://ci.chromium.org/b/8931691261485839072",
"utcnow_ts": "1540472465521101"
}
}
[13:01:05.536] Task URL: https://ci.chromium.org/b/8931691261485839072
[13:01:05.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:2:0) after 1m0s
[13:01:08.237] Received PubSub notification, asking Buildbucket for the build status
[13:01:08.284] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:05.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:2:0)
[13:02:05.583] Timer tick, asking Buildbucket for the build status
[13:02:05.627] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:05.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:4:0) after 1m0s
[13:03:05.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:4:0)
[13:03:05.647] Timer tick, asking Buildbucket for the build status
[13:03:05.723] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:05.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:5:0) after 1m0s
[13:04:05.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:5:0)
[13:04:05.747] Timer tick, asking Buildbucket for the build status
[13:04:05.810] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:05.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:6:0) after 1m0s
[13:05:05.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:6:0)
[13:05:05.877] Timer tick, asking Buildbucket for the build status
[13:05:06.041] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:06.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:7:0) after 1m0s
[13:06:06.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:7:0)
[13:06:06.066] Timer tick, asking Buildbucket for the build status
[13:06:06.112] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:06.112] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:8:0) after 1m0s
[13:07:06.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:8:0)
[13:07:06.137] Timer tick, asking Buildbucket for the build status
[13:07:06.181] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:9:0) after 1m0s
[13:08:06.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:9:0)
[13:08:06.206] Timer tick, asking Buildbucket for the build status
[13:08:06.289] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:06.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:10:0) after 1m0s
[13:09:06.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:10:0)
[13:09:06.309] Timer tick, asking Buildbucket for the build status
[13:09:06.390] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:06.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:11:0) after 1m0s
[13:10:06.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:11:0)
[13:10:06.413] Timer tick, asking Buildbucket for the build status
[13:10:06.482] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:06.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:12:0) after 1m0s
[13:11:06.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:12:0)
[13:11:06.529] Timer tick, asking Buildbucket for the build status
[13:11:06.624] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:06.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:13:0) after 1m0s
[13:12:06.641] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:13:0)
[13:12:06.641] Timer tick, asking Buildbucket for the build status
[13:12:06.722] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:06.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:14:0) after 1m0s
[13:13:06.738] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:14:0)
[13:13:06.738] Timer tick, asking Buildbucket for the build status
[13:13:06.851] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:06.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:15:0) after 1m0s
[13:14:06.875] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:15:0)
[13:14:06.875] Timer tick, asking Buildbucket for the build status
[13:14:06.976] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:06.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:16:0) after 1m0s
[13:15:07.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:16:0)
[13:15:07.021] Timer tick, asking Buildbucket for the build status
[13:15:07.109] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:07.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:17:0) after 1m0s
[13:16:07.184] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:17:0)
[13:16:07.184] Timer tick, asking Buildbucket for the build status
[13:16:07.222] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:07.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:18:0) after 1m0s
[13:17:07.324] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:18:0)
[13:17:07.324] Timer tick, asking Buildbucket for the build status
[13:17:07.556] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:07.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:19:0) after 1m0s
[13:18:07.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:19:0)
[13:18:07.575] Timer tick, asking Buildbucket for the build status
[13:18:07.623] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:07.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:20:0) after 1m0s
[13:19:07.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:20:0)
[13:19:07.658] Timer tick, asking Buildbucket for the build status
[13:19:07.687] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:07.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:21:0) after 1m0s
[13:20:07.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:21:0)
[13:20:07.711] Timer tick, asking Buildbucket for the build status
[13:20:07.748] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:07.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:22:0) after 1m0s
[13:21:07.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:22:0)
[13:21:07.770] Timer tick, asking Buildbucket for the build status
[13:21:07.835] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:07.835] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:23:0) after 1m0s
[13:22:07.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:23:0)
[13:22:07.864] Timer tick, asking Buildbucket for the build status
[13:22:08.009] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:08.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:24:0) after 1m0s
[13:23:08.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:24:0)
[13:23:08.081] Timer tick, asking Buildbucket for the build status
[13:23:08.172] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:08.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:25:0) after 1m0s
[13:24:08.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:25:0)
[13:24:08.262] Timer tick, asking Buildbucket for the build status
[13:24:08.327] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:08.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:26:0) after 1m0s
[13:25:08.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:26:0)
[13:25:08.347] Timer tick, asking Buildbucket for the build status
[13:25:08.390] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:08.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:27:0) after 1m0s
[13:26:08.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:27:0)
[13:26:08.411] Timer tick, asking Buildbucket for the build status
[13:26:08.472] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:08.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:28:0) after 1m0s
[13:27:08.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:28:0)
[13:27:08.497] Timer tick, asking Buildbucket for the build status
[13:27:08.570] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:08.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:29:0) after 1m0s
[13:28:08.600] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:29:0)
[13:28:08.600] Timer tick, asking Buildbucket for the build status
[13:28:08.695] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:08.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:30:0) after 1m0s
[13:29:08.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:30:0)
[13:29:08.722] Timer tick, asking Buildbucket for the build status
[13:29:08.813] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:08.813] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:31:0) after 1m0s
[13:30:08.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:31:0)
[13:30:08.873] Timer tick, asking Buildbucket for the build status
[13:30:08.934] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:08.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:32:0) after 1m0s
[13:31:08.954] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:32:0)
[13:31:08.955] Timer tick, asking Buildbucket for the build status
[13:31:09.012] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:09.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:33:0) after 1m0s
[13:32:09.030] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:33:0)
[13:32:09.030] Timer tick, asking Buildbucket for the build status
[13:32:09.173] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:09.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:34:0) after 1m0s
[13:33:09.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:34:0)
[13:33:09.197] Timer tick, asking Buildbucket for the build status
[13:33:09.245] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:09.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:35:0) after 1m0s
[13:34:09.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:35:0)
[13:34:09.265] Timer tick, asking Buildbucket for the build status
[13:34:09.325] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:09.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:36:0) after 1m0s
[13:35:09.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:36:0)
[13:35:09.352] Timer tick, asking Buildbucket for the build status
[13:35:10.248] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:10.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:37:0) after 1m0s
[13:36:10.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:37:0)
[13:36:10.275] Timer tick, asking Buildbucket for the build status
[13:36:10.334] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:10.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:38:0) after 1m0s
[13:37:10.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:38:0)
[13:37:10.387] Timer tick, asking Buildbucket for the build status
[13:37:10.442] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:10.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:39:0) after 1m0s
[13:38:10.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:39:0)
[13:38:10.488] Timer tick, asking Buildbucket for the build status
[13:38:10.527] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:10.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:40:0) after 1m0s
[13:39:10.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:40:0)
[13:39:10.555] Timer tick, asking Buildbucket for the build status
[13:39:10.637] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:10.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:41:0) after 1m0s
[13:40:10.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:41:0)
[13:40:10.663] Timer tick, asking Buildbucket for the build status
[13:40:10.714] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:10.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:42:0) after 1m0s
[13:41:10.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:42:0)
[13:41:10.755] Timer tick, asking Buildbucket for the build status
[13:41:10.902] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:10.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:43:0) after 1m0s
[13:42:10.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:43:0)
[13:42:10.923] Timer tick, asking Buildbucket for the build status
[13:42:10.991] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:10.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:44:0) after 1m0s
[13:43:11.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:44:0)
[13:43:11.012] Timer tick, asking Buildbucket for the build status
[13:43:11.117] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:11.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:45:0) after 1m0s
[13:44:11.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:45:0)
[13:44:11.142] Timer tick, asking Buildbucket for the build status
[13:44:11.251] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:11.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:46:0) after 1m0s
[13:45:11.280] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:46:0)
[13:45:11.280] Timer tick, asking Buildbucket for the build status
[13:45:11.347] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:11.347] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:47:0) after 1m0s
[13:46:11.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:47:0)
[13:46:11.373] Timer tick, asking Buildbucket for the build status
[13:46:11.412] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:11.412] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:48:0) after 1m0s
[13:47:11.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:48:0)
[13:47:11.437] Timer tick, asking Buildbucket for the build status
[13:47:11.500] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:11.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:49:0) after 1m0s
[13:48:11.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:49:0)
[13:48:11.598] Timer tick, asking Buildbucket for the build status
[13:48:11.640] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:11.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:50:0) after 1m0s
[13:49:11.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:50:0)
[13:49:11.669] Timer tick, asking Buildbucket for the build status
[13:49:11.971] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:11.971] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:51:0) after 1m0s
[13:50:12.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:51:0)
[13:50:12.001] Timer tick, asking Buildbucket for the build status
[13:50:12.036] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:12.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:52:0) after 1m0s
[13:51:12.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:52:0)
[13:51:12.105] Timer tick, asking Buildbucket for the build status
[13:51:12.179] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:12.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:53:0) after 1m0s
[13:52:12.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:53:0)
[13:52:12.219] Timer tick, asking Buildbucket for the build status
[13:52:12.313] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:12.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:54:0) after 1m0s
[13:53:12.379] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:54:0)
[13:53:12.379] Timer tick, asking Buildbucket for the build status
[13:53:12.516] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:12.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:55:0) after 1m0s
[13:54:12.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:55:0)
[13:54:12.608] Timer tick, asking Buildbucket for the build status
[13:54:12.687] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:12.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:56:0) after 1m0s
[13:55:12.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:56:0)
[13:55:12.718] Timer tick, asking Buildbucket for the build status
[13:55:12.778] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:12.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:57:0) after 1m0s
[13:56:12.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:57:0)
[13:56:12.818] Timer tick, asking Buildbucket for the build status
[13:56:12.929] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:12.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:58:0) after 1m0s
[13:57:12.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:58:0)
[13:57:12.961] Timer tick, asking Buildbucket for the build status
[13:57:13.000] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:13.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:59:0) after 1m0s
[13:58:13.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:59:0)
[13:58:13.031] Timer tick, asking Buildbucket for the build status
[13:58:13.101] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:13.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:60:0) after 1m0s
[13:59:13.130] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:60:0)
[13:59:13.130] Timer tick, asking Buildbucket for the build status
[13:59:13.168] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:13.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:61:0) after 1m0s
[14:00:13.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:61:0)
[14:00:13.204] Timer tick, asking Buildbucket for the build status
[14:00:13.373] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:13.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:62:0) after 1m0s
[14:01:13.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:62:0)
[14:01:13.400] Timer tick, asking Buildbucket for the build status
[14:01:13.434] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:13.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:63:0) after 1m0s
[14:02:13.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:63:0)
[14:02:13.461] Timer tick, asking Buildbucket for the build status
[14:02:13.562] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:13.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:64:0) after 1m0s
[14:03:13.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:64:0)
[14:03:13.607] Timer tick, asking Buildbucket for the build status
[14:03:13.714] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:13.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:65:0) after 1m0s
[14:04:13.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:65:0)
[14:04:13.736] Timer tick, asking Buildbucket for the build status
[14:04:13.796] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:13.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:66:0) after 1m0s
[14:05:13.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:66:0)
[14:05:13.826] Timer tick, asking Buildbucket for the build status
[14:05:13.866] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:13.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:67:0) after 1m0s
[14:06:13.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:67:0)
[14:06:13.897] Timer tick, asking Buildbucket for the build status
[14:06:13.958] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:13.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:68:0) after 1m0s
[14:07:13.987] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:68:0)
[14:07:13.987] Timer tick, asking Buildbucket for the build status
[14:07:14.034] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:14.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:69:0) after 1m0s
[14:08:14.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:69:0)
[14:08:14.067] Timer tick, asking Buildbucket for the build status
[14:08:14.144] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:14.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:70:0) after 1m0s
[14:09:14.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:70:0)
[14:09:14.173] Timer tick, asking Buildbucket for the build status
[14:09:14.289] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:14.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:71:0) after 1m0s
[14:10:14.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:71:0)
[14:10:14.386] Timer tick, asking Buildbucket for the build status
[14:10:14.417] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:14.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:72:0) after 1m0s
[14:11:14.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:72:0)
[14:11:14.488] Timer tick, asking Buildbucket for the build status
[14:11:14.542] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:14.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:73:0) after 1m0s
[14:12:14.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:73:0)
[14:12:14.571] Timer tick, asking Buildbucket for the build status
[14:12:14.612] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:14.612] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:74:0) after 1m0s
[14:13:14.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:74:0)
[14:13:14.634] Timer tick, asking Buildbucket for the build status
[14:13:14.697] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:13:14.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:75:0) after 1m0s
[14:14:14.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:75:0)
[14:14:14.745] Timer tick, asking Buildbucket for the build status
[14:14:14.780] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:14.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:76:0) after 1m0s
[14:15:14.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:76:0)
[14:15:14.800] Timer tick, asking Buildbucket for the build status
[14:15:14.860] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:14.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:77:0) after 1m0s
[14:16:14.923] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:77:0)
[14:16:14.923] Timer tick, asking Buildbucket for the build status
[14:16:14.964] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:14.964] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:78:0) after 1m0s
[14:17:14.989] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:78:0)
[14:17:14.989] Timer tick, asking Buildbucket for the build status
[14:17:15.057] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:15.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:79:0) after 1m0s
[14:18:15.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:79:0)
[14:18:15.083] Timer tick, asking Buildbucket for the build status
[14:18:15.123] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:15.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:80:0) after 1m0s
[14:19:15.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:80:0)
[14:19:15.142] Timer tick, asking Buildbucket for the build status
[14:19:15.213] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:15.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:81:0) after 1m0s
[14:20:15.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:81:0)
[14:20:15.239] Timer tick, asking Buildbucket for the build status
[14:20:15.447] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:15.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:82:0) after 1m0s
[14:21:15.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:82:0)
[14:21:15.479] Timer tick, asking Buildbucket for the build status
[14:21:15.522] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:15.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:83:0) after 1m0s
[14:22:15.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:83:0)
[14:22:15.661] Timer tick, asking Buildbucket for the build status
[14:22:15.710] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:15.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:84:0) after 1m0s
[14:23:15.757] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:84:0)
[14:23:15.757] Timer tick, asking Buildbucket for the build status
[14:23:15.854] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:15.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:85:0) after 1m0s
[14:24:15.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:85:0)
[14:24:15.899] Timer tick, asking Buildbucket for the build status
[14:24:16.012] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:16.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:86:0) after 1m0s
[14:25:16.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:86:0)
[14:25:16.040] Timer tick, asking Buildbucket for the build status
[14:25:16.082] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:16.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:87:0) after 1m0s
[14:26:16.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:87:0)
[14:26:16.106] Timer tick, asking Buildbucket for the build status
[14:26:16.143] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:16.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:88:0) after 1m0s
[14:27:16.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:88:0)
[14:27:16.175] Timer tick, asking Buildbucket for the build status
[14:27:16.326] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:16.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:89:0) after 1m0s
[14:28:16.359] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:89:0)
[14:28:16.359] Timer tick, asking Buildbucket for the build status
[14:28:16.508] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:28:16.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:90:0) after 1m0s
[14:29:16.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:90:0)
[14:29:16.537] Timer tick, asking Buildbucket for the build status
[14:29:16.651] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:29:16.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:91:0) after 1m0s
[14:30:16.675] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:91:0)
[14:30:16.675] Timer tick, asking Buildbucket for the build status
[14:30:16.720] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:30:16.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:92:0) after 1m0s
[14:31:16.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:92:0)
[14:31:16.750] Timer tick, asking Buildbucket for the build status
[14:31:16.795] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:31:16.795] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:93:0) after 1m0s
[14:32:16.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:93:0)
[14:32:16.828] Timer tick, asking Buildbucket for the build status
[14:32:17.094] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:32:17.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:94:0) after 1m0s
[14:33:17.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:94:0)
[14:33:17.173] Timer tick, asking Buildbucket for the build status
[14:33:17.228] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:33:17.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:95:0) after 1m0s
[14:34:17.251] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:95:0)
[14:34:17.251] Timer tick, asking Buildbucket for the build status
[14:34:17.303] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:34:17.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:96:0) after 1m0s
[14:35:17.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:96:0)
[14:35:17.334] Timer tick, asking Buildbucket for the build status
[14:35:17.393] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:35:17.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:97:0) after 1m0s
[14:36:17.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:97:0)
[14:36:17.419] Timer tick, asking Buildbucket for the build status
[14:36:17.481] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:36:17.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:98:0) after 1m0s
[14:37:17.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:98:0)
[14:37:17.518] Timer tick, asking Buildbucket for the build status
[14:37:17.559] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:37:17.559] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:99:0) after 1m0s
[14:38:17.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:99:0)
[14:38:17.613] Timer tick, asking Buildbucket for the build status
[14:38:17.680] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:38:17.680] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:100:0) after 1m0s
[14:39:17.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:100:0)
[14:39:17.706] Timer tick, asking Buildbucket for the build status
[14:39:17.786] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:39:17.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:101:0) after 1m0s
[14:40:17.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:101:0)
[14:40:17.812] Timer tick, asking Buildbucket for the build status
[14:40:17.850] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:40:17.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:102:0) after 1m0s
[14:41:17.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:102:0)
[14:41:17.876] Timer tick, asking Buildbucket for the build status
[14:41:17.938] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:17.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:103:0) after 1m0s
[14:42:17.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:103:0)
[14:42:17.965] Timer tick, asking Buildbucket for the build status
[14:42:17.997] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:17.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:104:0) after 1m0s
[14:43:18.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:104:0)
[14:43:18.035] Timer tick, asking Buildbucket for the build status
[14:43:18.129] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:18.129] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:105:0) after 1m0s
[14:44:18.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:105:0)
[14:44:18.284] Timer tick, asking Buildbucket for the build status
[14:44:18.380] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:18.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:106:0) after 1m0s
[14:45:18.414] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:106:0)
[14:45:18.414] Timer tick, asking Buildbucket for the build status
[14:45:18.452] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:18.452] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:107:0) after 1m0s
[14:46:18.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:107:0)
[14:46:18.477] Timer tick, asking Buildbucket for the build status
[14:46:18.549] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:18.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:108:0) after 1m0s
[14:47:18.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:108:0)
[14:47:18.576] Timer tick, asking Buildbucket for the build status
[14:47:18.627] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:18.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:109:0) after 1m0s
[14:48:18.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:109:0)
[14:48:18.650] Timer tick, asking Buildbucket for the build status
[14:48:18.740] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:18.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:110:0) after 1m0s
[14:49:18.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:110:0)
[14:49:18.765] Timer tick, asking Buildbucket for the build status
[14:49:18.806] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:18.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:111:0) after 1m0s
[14:50:18.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:111:0)
[14:50:18.839] Timer tick, asking Buildbucket for the build status
[14:50:18.988] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:18.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:112:0) after 1m0s
[14:51:19.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:112:0)
[14:51:19.022] Timer tick, asking Buildbucket for the build status
[14:51:19.090] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:19.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:113:0) after 1m0s
[14:52:19.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:113:0)
[14:52:19.121] Timer tick, asking Buildbucket for the build status
[14:52:19.196] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:19.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:114:0) after 1m0s
[14:53:19.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:114:0)
[14:53:19.220] Timer tick, asking Buildbucket for the build status
[14:53:19.259] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:19.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:115:0) after 1m0s
[14:54:19.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:115:0)
[14:54:19.297] Timer tick, asking Buildbucket for the build status
[14:54:19.481] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:19.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:116:0) after 1m0s
[14:55:19.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:116:0)
[14:55:19.535] Timer tick, asking Buildbucket for the build status
[14:55:19.633] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:19.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:117:0) after 1m0s
[14:56:19.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:117:0)
[14:56:19.720] Timer tick, asking Buildbucket for the build status
[14:56:19.796] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:19.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:118:0) after 1m0s
[14:57:19.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:118:0)
[14:57:19.824] Timer tick, asking Buildbucket for the build status
[14:57:19.860] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:19.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:119:0) after 1m0s
[14:58:19.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:119:0)
[14:58:19.908] Timer tick, asking Buildbucket for the build status
[14:58:20.034] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:20.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:120:0) after 1m0s
[14:59:20.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:120:0)
[14:59:20.061] Timer tick, asking Buildbucket for the build status
[14:59:20.116] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:20.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:121:0) after 1m0s
[15:00:20.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:121:0)
[15:00:20.181] Timer tick, asking Buildbucket for the build status
[15:00:20.231] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:20.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:122:0) after 1m0s
[15:01:20.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:122:0)
[15:01:20.293] Timer tick, asking Buildbucket for the build status
[15:01:20.409] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:20.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:123:0) after 1m0s
[15:02:20.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:123:0)
[15:02:20.446] Timer tick, asking Buildbucket for the build status
[15:02:20.514] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:20.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:124:0) after 1m0s
[15:03:20.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:124:0)
[15:03:20.546] Timer tick, asking Buildbucket for the build status
[15:03:20.639] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:20.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:125:0) after 1m0s
[15:04:20.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:125:0)
[15:04:20.682] Timer tick, asking Buildbucket for the build status
[15:04:20.719] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:20.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:126:0) after 1m0s
[15:05:20.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:126:0)
[15:05:20.753] Timer tick, asking Buildbucket for the build status
[15:05:20.795] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:20.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:127:0) after 1m0s
[15:06:20.841] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:127:0)
[15:06:20.841] Timer tick, asking Buildbucket for the build status
[15:06:20.972] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:20.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:128:0) after 1m0s
[15:07:21.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:128:0)
[15:07:21.085] Timer tick, asking Buildbucket for the build status
[15:07:21.125] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:21.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:129:0) after 1m0s
[15:08:21.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:129:0)
[15:08:21.152] Timer tick, asking Buildbucket for the build status
[15:08:21.256] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:21.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:130:0) after 1m0s
[15:09:21.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:130:0)
[15:09:21.282] Timer tick, asking Buildbucket for the build status
[15:09:21.323] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:21.323] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:131:0) after 1m0s
[15:10:21.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:131:0)
[15:10:21.346] Timer tick, asking Buildbucket for the build status
[15:10:21.426] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:21.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:132:0) after 1m0s
[15:11:21.452] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:132:0)
[15:11:21.452] Timer tick, asking Buildbucket for the build status
[15:11:21.536] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:21.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:133:0) after 1m0s
[15:12:21.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:133:0)
[15:12:21.570] Timer tick, asking Buildbucket for the build status
[15:12:21.663] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:21.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:134:0) after 1m0s
[15:13:22.100] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:134:0)
[15:13:22.100] Timer tick, asking Buildbucket for the build status
[15:13:22.380] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:22.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:135:0) after 1m0s
[15:14:23.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:135:0)
[15:14:23.025] Timer tick, asking Buildbucket for the build status
[15:14:23.089] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:23.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:136:0) after 1m0s
[15:15:23.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:136:0)
[15:15:23.117] Timer tick, asking Buildbucket for the build status
[15:15:23.155] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:23.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:137:0) after 1m0s
[15:16:23.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:137:0)
[15:16:23.185] Timer tick, asking Buildbucket for the build status
[15:16:23.245] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:23.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:138:0) after 1m0s
[15:17:23.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:138:0)
[15:17:23.293] Timer tick, asking Buildbucket for the build status
[15:17:23.338] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:23.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:139:0) after 1m0s
[15:18:23.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:139:0)
[15:18:23.369] Timer tick, asking Buildbucket for the build status
[15:18:23.456] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:23.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:140:0) after 1m0s
[15:19:23.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:140:0)
[15:19:23.496] Timer tick, asking Buildbucket for the build status
[15:19:23.632] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:23.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:141:0) after 1m0s
[15:20:23.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:141:0)
[15:20:23.656] Timer tick, asking Buildbucket for the build status
[15:20:23.775] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:23.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:142:0) after 1m0s
[15:21:23.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:142:0)
[15:21:23.801] Timer tick, asking Buildbucket for the build status
[15:21:23.884] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:23.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:143:0) after 1m0s
[15:22:23.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:143:0)
[15:22:23.985] Timer tick, asking Buildbucket for the build status
[15:22:24.084] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:24.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:144:0) after 1m0s
[15:23:24.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:144:0)
[15:23:24.112] Timer tick, asking Buildbucket for the build status
[15:23:24.187] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:24.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:145:0) after 1m0s
[15:24:24.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:145:0)
[15:24:24.279] Timer tick, asking Buildbucket for the build status
[15:24:24.339] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:24.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:146:0) after 1m0s
[15:25:24.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:146:0)
[15:25:24.370] Timer tick, asking Buildbucket for the build status
[15:25:24.515] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:24.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:147:0) after 1m0s
[15:26:24.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:147:0)
[15:26:24.544] Timer tick, asking Buildbucket for the build status
[15:26:24.604] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:24.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:148:0) after 1m0s
[15:27:24.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:148:0)
[15:27:24.679] Timer tick, asking Buildbucket for the build status
[15:27:24.719] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:24.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:149:0) after 1m0s
[15:28:24.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:149:0)
[15:28:24.794] Timer tick, asking Buildbucket for the build status
[15:28:24.850] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:24.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:150:0) after 1m0s
[15:29:24.882] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:150:0)
[15:29:24.882] Timer tick, asking Buildbucket for the build status
[15:29:24.924] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:24.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:151:0) after 1m0s
[15:30:24.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:151:0)
[15:30:24.949] Timer tick, asking Buildbucket for the build status
[15:30:25.060] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:25.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:152:0) after 1m0s
[15:31:25.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:152:0)
[15:31:25.092] Timer tick, asking Buildbucket for the build status
[15:31:25.151] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:25.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:153:0) after 1m0s
[15:32:25.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:153:0)
[15:32:25.177] Timer tick, asking Buildbucket for the build status
[15:32:25.309] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:25.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:154:0) after 1m0s
[15:33:25.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:154:0)
[15:33:25.333] Timer tick, asking Buildbucket for the build status
[15:33:25.397] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:25.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:155:0) after 1m0s
[15:34:25.481] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:155:0)
[15:34:25.481] Timer tick, asking Buildbucket for the build status
[15:34:25.682] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:25.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:156:0) after 1m0s
[15:35:25.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:156:0)
[15:35:25.709] Timer tick, asking Buildbucket for the build status
[15:35:25.833] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:25.833] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:157:0) after 1m0s
[15:36:25.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:157:0)
[15:36:25.866] Timer tick, asking Buildbucket for the build status
[15:36:25.957] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:25.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:158:0) after 1m0s
[15:37:25.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:158:0)
[15:37:25.986] Timer tick, asking Buildbucket for the build status
[15:37:26.037] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:26.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:159:0) after 1m0s
[15:38:26.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:159:0)
[15:38:26.063] Timer tick, asking Buildbucket for the build status
[15:38:26.145] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:26.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:160:0) after 1m0s
[15:39:26.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:160:0)
[15:39:26.177] Timer tick, asking Buildbucket for the build status
[15:39:26.232] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:26.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:161:0) after 1m0s
[15:40:26.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:161:0)
[15:40:26.318] Timer tick, asking Buildbucket for the build status
[15:40:26.382] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:26.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:162:0) after 1m0s
[15:41:26.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:162:0)
[15:41:26.409] Timer tick, asking Buildbucket for the build status
[15:41:26.507] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:26.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:163:0) after 1m0s
[15:42:26.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:163:0)
[15:42:26.543] Timer tick, asking Buildbucket for the build status
[15:42:26.670] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:26.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:164:0) after 1m0s
[15:43:26.697] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:164:0)
[15:43:26.697] Timer tick, asking Buildbucket for the build status
[15:43:26.873] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:26.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:165:0) after 1m0s
[15:44:26.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:165:0)
[15:44:26.898] Timer tick, asking Buildbucket for the build status
[15:44:26.952] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:26.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:166:0) after 1m0s
[15:45:26.992] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:166:0)
[15:45:26.992] Timer tick, asking Buildbucket for the build status
[15:45:27.049] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:27.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:167:0) after 1m0s
[15:46:27.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:167:0)
[15:46:27.105] Timer tick, asking Buildbucket for the build status
[15:46:27.168] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:27.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:168:0) after 1m0s
[15:47:27.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:168:0)
[15:47:27.203] Timer tick, asking Buildbucket for the build status
[15:47:27.257] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:27.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:169:0) after 1m0s
[15:48:27.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:169:0)
[15:48:27.281] Timer tick, asking Buildbucket for the build status
[15:48:27.335] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:27.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:170:0) after 1m0s
[15:49:27.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:170:0)
[15:49:27.361] Timer tick, asking Buildbucket for the build status
[15:49:27.395] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:27.395] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:171:0) after 1m0s
[15:50:27.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:171:0)
[15:50:27.424] Timer tick, asking Buildbucket for the build status
[15:50:27.488] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:27.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:172:0) after 1m0s
[15:51:27.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:172:0)
[15:51:27.516] Timer tick, asking Buildbucket for the build status
[15:51:27.574] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:27.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:173:0) after 1m0s
[15:52:27.605] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:173:0)
[15:52:27.605] Timer tick, asking Buildbucket for the build status
[15:52:27.645] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:174:0) after 1m0s
[15:53:27.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:174:0)
[15:53:27.681] Timer tick, asking Buildbucket for the build status
[15:53:27.719] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:27.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:175:0) after 1m0s
[15:54:27.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:175:0)
[15:54:27.749] Timer tick, asking Buildbucket for the build status
[15:54:27.805] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:27.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:176:0) after 1m0s
[15:55:27.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:176:0)
[15:55:27.828] Timer tick, asking Buildbucket for the build status
[15:55:27.866] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:27.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:177:0) after 1m0s
[15:56:27.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:177:0)
[15:56:27.900] Timer tick, asking Buildbucket for the build status
[15:56:27.970] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:27.970] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:178:0) after 1m0s
[15:57:27.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:178:0)
[15:57:27.997] Timer tick, asking Buildbucket for the build status
[15:57:28.035] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:28.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:179:0) after 1m0s
[15:58:28.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:179:0)
[15:58:28.072] Timer tick, asking Buildbucket for the build status
[15:58:28.124] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:28.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:180:0) after 1m0s
[15:59:28.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:180:0)
[15:59:28.148] Timer tick, asking Buildbucket for the build status
[15:59:28.211] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:28.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:181:0) after 1m0s
[16:00:28.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:181:0)
[16:00:28.286] Timer tick, asking Buildbucket for the build status
[16:00:28.414] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:28.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:182:0) after 1m0s
[16:01:28.480] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:182:0)
[16:01:28.480] Timer tick, asking Buildbucket for the build status
[16:01:28.544] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:28.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:183:0) after 1m0s
[16:02:28.576] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:183:0)
[16:02:28.576] Timer tick, asking Buildbucket for the build status
[16:02:30.266] Build 8931691261485839072: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:30.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097121323598041488:184:0) after 1m0s
[16:02:39.894] Received PubSub notification, asking Buildbucket for the build status
[16:02:39.934] Build 8931691261485839072: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[16:02:39.934] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1540483358731535",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540472464058956",
"failure_reason": "INFRA_FAILURE",
"id": "8931691261485839072",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"92aa42c2a5abb0842a83e306e287eb4467b48f56\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"bot_dimensions\": {\"machine_type\": [\"n1-standard-8\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"locale\": [\"en_US.cp1252\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"builder\": [\"Windows deterministic\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\"], \"python\": [\"2.7.6\"], \"server_version\": [\"3817-6aedaff\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540472467290635",
"status": "COMPLETED",
"status_changed_ts": "1540483359331432",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10517",
"builder:Windows deterministic",
"buildset:commit/git/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097121323598041488",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10517",
"swarming_tag:buildbucket_bucket:chromium/ci",
"swarming_tag:buildbucket_build_id:8931691261485839072",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:c1e4e074f3337ff2dbbfb9aa3b0475a61adb09a6",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/92aa42c2a5abb0842a83e306e287eb4467b48f56",
"swarming_tag:caches:builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8931691261485839072/+/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:9097121323598041488",
"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:d633426da4cba82a1896950c9ffa957dc80b54e5",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40c421ed12961010",
"user_agent:luci-scheduler"
],
"updated_ts": "1540483359332310",
"url": "https://ci.chromium.org/b/8931691261485839072",
"utcnow_ts": "1540483359922081"
}
}
[16:02:39.934] Invocation finished in 3h1m37.273376712s with status FAILED