[11:40:54.172] New invocation is queued and will start shortly
[11:40:55.548] Starting the invocation (attempt 1)
[11:40:55.634] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:40:55.634] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:40:55.634] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097669947479358048",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097669947479358048",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"gitiles_ref:refs/heads/master"
]
}
[11:40:57.804] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539949255722937",
"id": "8932239885189973536",
"lease_expiration_ts": "1540093257298515",
"lease_key": "1051214356",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1539949257651555",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10450",
"builder:Windows deterministic",
"buildset:commit/git/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097669947479358048",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10450",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932239885189973536",
"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/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8932239885189973536/+/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:9097669947479358048",
"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:86f8743ced46ac7ae8a49d5f70eecbcfd17feac4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40a4f2688c051810",
"user_agent:luci-scheduler"
],
"updated_ts": "1539949257651649",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10450",
"utcnow_ts": "1539949257787516"
}
}
[11:40:57.804] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10450
[11:40:57.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:2:0) after 1m0s
[11:40:59.319] Received PubSub notification, asking Buildbucket for the build status
[11:40:59.364] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:57.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:2:0)
[11:41:57.891] Timer tick, asking Buildbucket for the build status
[11:41:57.934] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:57.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:4:0) after 1m0s
[11:42:57.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:4:0)
[11:42:57.965] Timer tick, asking Buildbucket for the build status
[11:42:58.008] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:58.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:5:0) after 1m0s
[11:43:58.028] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:5:0)
[11:43:58.028] Timer tick, asking Buildbucket for the build status
[11:43:58.093] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:58.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:6:0) after 1m0s
[11:44:58.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:6:0)
[11:44:58.112] Timer tick, asking Buildbucket for the build status
[11:44:58.228] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:58.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:7:0) after 1m0s
[11:45:58.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:7:0)
[11:45:58.343] Timer tick, asking Buildbucket for the build status
[11:45:58.423] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:58.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:8:0) after 1m0s
[11:46:58.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:8:0)
[11:46:58.461] Timer tick, asking Buildbucket for the build status
[11:46:58.541] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:58.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:9:0) after 1m0s
[11:47:58.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:9:0)
[11:47:58.558] Timer tick, asking Buildbucket for the build status
[11:47:58.610] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:58.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:10:0) after 1m0s
[11:48:58.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:10:0)
[11:48:58.632] Timer tick, asking Buildbucket for the build status
[11:48:58.867] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:58.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:11:0) after 1m0s
[11:49:58.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:11:0)
[11:49:58.889] Timer tick, asking Buildbucket for the build status
[11:49:58.996] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:58.996] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:12:0) after 1m0s
[11:50:59.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:12:0)
[11:50:59.018] Timer tick, asking Buildbucket for the build status
[11:50:59.089] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:59.089] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:13:0) after 1m0s
[11:51:59.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:13:0)
[11:51:59.122] Timer tick, asking Buildbucket for the build status
[11:51:59.181] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:59.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:14:0) after 1m0s
[11:52:59.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:14:0)
[11:52:59.200] Timer tick, asking Buildbucket for the build status
[11:52:59.262] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:59.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:15:0) after 1m0s
[11:53:59.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:15:0)
[11:53:59.288] Timer tick, asking Buildbucket for the build status
[11:53:59.387] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:59.387] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:16:0) after 1m0s
[11:54:59.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:16:0)
[11:54:59.404] Timer tick, asking Buildbucket for the build status
[11:54:59.594] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:59.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:17:0) after 1m0s
[11:55:59.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:17:0)
[11:55:59.615] Timer tick, asking Buildbucket for the build status
[11:55:59.660] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:59.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:18:0) after 1m0s
[11:56:59.712] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:18:0)
[11:56:59.712] Timer tick, asking Buildbucket for the build status
[11:56:59.783] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:59.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:19:0) after 1m0s
[11:57:59.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:19:0)
[11:57:59.806] Timer tick, asking Buildbucket for the build status
[11:57:59.941] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:59.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:20:0) after 1m0s
[11:58:59.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:20:0)
[11:58:59.963] Timer tick, asking Buildbucket for the build status
[11:59:00.041] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:00.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:21:0) after 1m0s
[12:00:00.066] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:21:0)
[12:00:00.066] Timer tick, asking Buildbucket for the build status
[12:00:00.151] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:00.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:22:0) after 1m0s
[12:01:00.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:22:0)
[12:01:00.170] Timer tick, asking Buildbucket for the build status
[12:01:00.244] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:00.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:23:0) after 1m0s
[12:02:00.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:23:0)
[12:02:00.264] Timer tick, asking Buildbucket for the build status
[12:02:00.335] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:00.335] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:24:0) after 1m0s
[12:03:00.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:24:0)
[12:03:00.355] Timer tick, asking Buildbucket for the build status
[12:03:00.406] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:00.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:25:0) after 1m0s
[12:04:00.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:25:0)
[12:04:00.425] Timer tick, asking Buildbucket for the build status
[12:04:00.471] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:00.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:26:0) after 1m0s
[12:05:00.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:26:0)
[12:05:00.488] Timer tick, asking Buildbucket for the build status
[12:05:00.549] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:00.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:27:0) after 1m0s
[12:06:00.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:27:0)
[12:06:00.572] Timer tick, asking Buildbucket for the build status
[12:06:00.640] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:00.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:28:0) after 1m0s
[12:07:00.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:28:0)
[12:07:00.663] Timer tick, asking Buildbucket for the build status
[12:07:00.908] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:00.908] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:29:0) after 1m0s
[12:08:00.927] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:29:0)
[12:08:00.927] Timer tick, asking Buildbucket for the build status
[12:08:01.026] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:01.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:30:0) after 1m0s
[12:09:01.050] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:30:0)
[12:09:01.050] Timer tick, asking Buildbucket for the build status
[12:09:01.163] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:01.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:31:0) after 1m0s
[12:10:01.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:31:0)
[12:10:01.182] Timer tick, asking Buildbucket for the build status
[12:10:01.244] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:01.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:32:0) after 1m0s
[12:11:01.262] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:32:0)
[12:11:01.262] Timer tick, asking Buildbucket for the build status
[12:11:01.348] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:01.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:33:0) after 1m0s
[12:12:01.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:33:0)
[12:12:01.388] Timer tick, asking Buildbucket for the build status
[12:12:01.618] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:01.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:34:0) after 1m0s
[12:13:01.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:34:0)
[12:13:01.647] Timer tick, asking Buildbucket for the build status
[12:13:01.723] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:01.723] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:35:0) after 1m0s
[12:14:01.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:35:0)
[12:14:01.822] Timer tick, asking Buildbucket for the build status
[12:14:02.076] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:36:0) after 1m0s
[12:15:02.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:36:0)
[12:15:02.098] Timer tick, asking Buildbucket for the build status
[12:15:02.202] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:02.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:37:0) after 1m0s
[12:16:02.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:37:0)
[12:16:02.222] Timer tick, asking Buildbucket for the build status
[12:16:02.331] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:02.331] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:38:0) after 1m0s
[12:17:02.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:38:0)
[12:17:02.381] Timer tick, asking Buildbucket for the build status
[12:17:02.414] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:02.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:39:0) after 1m0s
[12:18:02.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:39:0)
[12:18:02.433] Timer tick, asking Buildbucket for the build status
[12:18:02.608] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:02.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:40:0) after 1m0s
[12:19:02.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:40:0)
[12:19:02.636] Timer tick, asking Buildbucket for the build status
[12:19:02.713] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:02.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:41:0) after 1m0s
[12:20:02.740] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:41:0)
[12:20:02.740] Timer tick, asking Buildbucket for the build status
[12:20:02.826] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:02.826] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:42:0) after 1m0s
[12:21:02.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:42:0)
[12:21:02.843] Timer tick, asking Buildbucket for the build status
[12:21:02.934] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:02.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:43:0) after 1m0s
[12:22:02.953] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:43:0)
[12:22:02.953] Timer tick, asking Buildbucket for the build status
[12:22:03.130] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:03.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:44:0) after 1m0s
[12:23:03.150] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:44:0)
[12:23:03.150] Timer tick, asking Buildbucket for the build status
[12:23:03.188] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:03.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:45:0) after 1m0s
[12:24:03.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:45:0)
[12:24:03.208] Timer tick, asking Buildbucket for the build status
[12:24:05.262] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:05.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:46:0) after 1m0s
[12:25:05.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:46:0)
[12:25:05.300] Timer tick, asking Buildbucket for the build status
[12:25:05.360] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:05.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:47:0) after 1m0s
[12:26:05.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:47:0)
[12:26:05.403] Timer tick, asking Buildbucket for the build status
[12:26:05.641] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:05.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:48:0) after 1m0s
[12:27:05.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:48:0)
[12:27:05.659] Timer tick, asking Buildbucket for the build status
[12:27:05.725] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:05.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:49:0) after 1m0s
[12:28:05.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:49:0)
[12:28:05.743] Timer tick, asking Buildbucket for the build status
[12:28:05.808] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:05.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:50:0) after 1m0s
[12:29:05.829] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:50:0)
[12:29:05.829] Timer tick, asking Buildbucket for the build status
[12:29:05.931] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:05.931] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:51:0) after 1m0s
[12:30:05.949] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:51:0)
[12:30:05.949] Timer tick, asking Buildbucket for the build status
[12:30:06.311] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:06.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:52:0) after 1m0s
[12:31:06.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:52:0)
[12:31:06.337] Timer tick, asking Buildbucket for the build status
[12:31:07.085] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:07.085] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:53:0) after 1m0s
[12:32:07.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:53:0)
[12:32:07.103] Timer tick, asking Buildbucket for the build status
[12:32:07.200] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:07.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:54:0) after 1m0s
[12:33:07.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:54:0)
[12:33:07.224] Timer tick, asking Buildbucket for the build status
[12:33:07.304] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:07.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:55:0) after 1m0s
[12:34:07.322] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:55:0)
[12:34:07.322] Timer tick, asking Buildbucket for the build status
[12:34:07.475] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:07.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:56:0) after 1m0s
[12:35:07.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:56:0)
[12:35:07.495] Timer tick, asking Buildbucket for the build status
[12:35:07.587] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:07.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:57:0) after 1m0s
[12:36:07.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:57:0)
[12:36:07.607] Timer tick, asking Buildbucket for the build status
[12:36:07.641] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:07.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:58:0) after 1m0s
[12:37:07.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:58:0)
[12:37:07.660] Timer tick, asking Buildbucket for the build status
[12:37:07.719] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:07.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:59:0) after 1m0s
[12:38:07.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:59:0)
[12:38:07.751] Timer tick, asking Buildbucket for the build status
[12:38:07.816] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:07.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:60:0) after 1m0s
[12:39:07.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:60:0)
[12:39:07.835] Timer tick, asking Buildbucket for the build status
[12:39:08.187] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:08.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:61:0) after 1m0s
[12:40:08.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:61:0)
[12:40:08.209] Timer tick, asking Buildbucket for the build status
[12:40:08.279] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:08.279] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:62:0) after 1m0s
[12:41:08.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:62:0)
[12:41:08.349] Timer tick, asking Buildbucket for the build status
[12:41:08.437] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:08.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:63:0) after 1m0s
[12:42:08.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:63:0)
[12:42:08.454] Timer tick, asking Buildbucket for the build status
[12:42:08.606] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:08.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:64:0) after 1m0s
[12:43:08.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:64:0)
[12:43:08.628] Timer tick, asking Buildbucket for the build status
[12:43:09.001] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:09.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:65:0) after 1m0s
[12:44:09.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:65:0)
[12:44:09.037] Timer tick, asking Buildbucket for the build status
[12:44:09.162] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:09.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:66:0) after 1m0s
[12:45:09.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:66:0)
[12:45:09.186] Timer tick, asking Buildbucket for the build status
[12:45:09.230] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:09.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:67:0) after 1m0s
[12:46:09.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:67:0)
[12:46:09.255] Timer tick, asking Buildbucket for the build status
[12:46:09.340] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:09.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:68:0) after 1m0s
[12:47:09.361] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:68:0)
[12:47:09.361] Timer tick, asking Buildbucket for the build status
[12:47:09.422] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:09.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:69:0) after 1m0s
[12:48:09.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:69:0)
[12:48:09.439] Timer tick, asking Buildbucket for the build status
[12:48:09.507] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:09.507] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:70:0) after 1m0s
[12:49:09.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:70:0)
[12:49:09.626] Timer tick, asking Buildbucket for the build status
[12:49:09.706] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:09.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:71:0) after 1m0s
[12:50:09.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:71:0)
[12:50:09.761] Timer tick, asking Buildbucket for the build status
[12:50:09.913] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:09.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:72:0) after 1m0s
[12:51:09.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:72:0)
[12:51:09.938] Timer tick, asking Buildbucket for the build status
[12:51:10.026] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:10.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:73:0) after 1m0s
[12:52:10.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:73:0)
[12:52:10.081] Timer tick, asking Buildbucket for the build status
[12:52:10.189] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:10.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:74:0) after 1m0s
[12:53:10.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:74:0)
[12:53:10.213] Timer tick, asking Buildbucket for the build status
[12:53:10.319] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:10.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:75:0) after 1m0s
[12:54:10.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:75:0)
[12:54:10.353] Timer tick, asking Buildbucket for the build status
[12:54:10.390] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:10.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:76:0) after 1m0s
[12:55:10.428] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:76:0)
[12:55:10.428] Timer tick, asking Buildbucket for the build status
[12:55:10.557] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:10.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:77:0) after 1m0s
[12:56:10.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:77:0)
[12:56:10.638] Timer tick, asking Buildbucket for the build status
[12:56:10.784] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:10.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:78:0) after 1m0s
[12:57:10.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:78:0)
[12:57:10.803] Timer tick, asking Buildbucket for the build status
[12:57:10.921] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:10.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:79:0) after 1m0s
[12:58:10.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:79:0)
[12:58:10.946] Timer tick, asking Buildbucket for the build status
[12:58:10.988] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:10.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:80:0) after 1m0s
[12:59:11.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:80:0)
[12:59:11.057] Timer tick, asking Buildbucket for the build status
[12:59:11.092] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:11.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:81:0) after 1m0s
[13:00:11.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:81:0)
[13:00:11.129] Timer tick, asking Buildbucket for the build status
[13:00:11.328] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:11.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:82:0) after 1m0s
[13:01:11.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:82:0)
[13:01:11.355] Timer tick, asking Buildbucket for the build status
[13:01:11.542] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:11.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:83:0) after 1m0s
[13:02:11.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:83:0)
[13:02:11.562] Timer tick, asking Buildbucket for the build status
[13:02:11.632] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:11.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:84:0) after 1m0s
[13:03:11.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:84:0)
[13:03:11.650] Timer tick, asking Buildbucket for the build status
[13:03:11.777] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:11.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:85:0) after 1m0s
[13:04:11.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:85:0)
[13:04:11.799] Timer tick, asking Buildbucket for the build status
[13:04:11.839] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:11.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:86:0) after 1m0s
[13:05:11.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:86:0)
[13:05:11.862] Timer tick, asking Buildbucket for the build status
[13:05:11.901] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:11.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:87:0) after 1m0s
[13:06:11.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:87:0)
[13:06:11.935] Timer tick, asking Buildbucket for the build status
[13:06:12.093] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:12.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:88:0) after 1m0s
[13:07:12.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:88:0)
[13:07:12.173] Timer tick, asking Buildbucket for the build status
[13:07:12.487] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:12.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:89:0) after 1m0s
[13:08:12.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:89:0)
[13:08:12.508] Timer tick, asking Buildbucket for the build status
[13:08:12.543] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:90:0) after 1m0s
[13:09:12.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:90:0)
[13:09:12.587] Timer tick, asking Buildbucket for the build status
[13:09:12.624] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:12.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:91:0) after 1m0s
[13:10:12.643] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:91:0)
[13:10:12.643] Timer tick, asking Buildbucket for the build status
[13:10:12.724] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:12.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:92:0) after 1m0s
[13:11:12.789] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:92:0)
[13:11:12.789] Timer tick, asking Buildbucket for the build status
[13:11:13.024] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:13.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:93:0) after 1m0s
[13:12:13.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:93:0)
[13:12:13.046] Timer tick, asking Buildbucket for the build status
[13:12:13.110] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:13.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:94:0) after 1m0s
[13:13:13.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:94:0)
[13:13:13.134] Timer tick, asking Buildbucket for the build status
[13:13:13.193] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:13.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:95:0) after 1m0s
[13:14:13.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:95:0)
[13:14:13.315] Timer tick, asking Buildbucket for the build status
[13:14:13.384] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:13.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:96:0) after 1m0s
[13:15:13.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:96:0)
[13:15:13.413] Timer tick, asking Buildbucket for the build status
[13:15:13.528] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:13.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:97:0) after 1m0s
[13:16:13.616] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:97:0)
[13:16:13.616] Timer tick, asking Buildbucket for the build status
[13:16:13.651] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:13.651] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:98:0) after 1m0s
[13:17:13.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:98:0)
[13:17:13.717] Timer tick, asking Buildbucket for the build status
[13:17:13.774] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:13.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:99:0) after 1m0s
[13:18:13.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:99:0)
[13:18:13.797] Timer tick, asking Buildbucket for the build status
[13:18:13.853] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:13.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:100:0) after 1m0s
[13:19:13.880] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:100:0)
[13:19:13.880] Timer tick, asking Buildbucket for the build status
[13:19:13.942] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:13.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:101:0) after 1m0s
[13:20:13.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:101:0)
[13:20:13.964] Timer tick, asking Buildbucket for the build status
[13:20:14.046] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:14.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:102:0) after 1m0s
[13:21:14.070] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:102:0)
[13:21:14.070] Timer tick, asking Buildbucket for the build status
[13:21:14.147] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:14.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:103:0) after 1m0s
[13:22:14.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:103:0)
[13:22:14.220] Timer tick, asking Buildbucket for the build status
[13:22:14.407] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:14.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:104:0) after 1m0s
[13:23:14.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:104:0)
[13:23:14.460] Timer tick, asking Buildbucket for the build status
[13:23:14.512] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:14.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:105:0) after 1m0s
[13:24:14.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:105:0)
[13:24:14.536] Timer tick, asking Buildbucket for the build status
[13:24:14.613] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:14.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:106:0) after 1m0s
[13:25:14.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:106:0)
[13:25:14.633] Timer tick, asking Buildbucket for the build status
[13:25:14.675] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:14.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:107:0) after 1m0s
[13:26:14.700] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:107:0)
[13:26:14.700] Timer tick, asking Buildbucket for the build status
[13:26:14.827] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:14.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:108:0) after 1m0s
[13:27:14.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:108:0)
[13:27:14.853] Timer tick, asking Buildbucket for the build status
[13:27:14.963] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:14.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:109:0) after 1m0s
[13:28:15.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:109:0)
[13:28:15.008] Timer tick, asking Buildbucket for the build status
[13:28:15.083] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:15.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:110:0) after 1m0s
[13:29:15.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:110:0)
[13:29:15.107] Timer tick, asking Buildbucket for the build status
[13:29:15.255] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:15.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:111:0) after 1m0s
[13:30:15.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:111:0)
[13:30:15.308] Timer tick, asking Buildbucket for the build status
[13:30:15.364] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:15.364] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:112:0) after 1m0s
[13:31:15.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:112:0)
[13:31:15.390] Timer tick, asking Buildbucket for the build status
[13:31:15.447] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:15.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:113:0) after 1m0s
[13:32:15.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:113:0)
[13:32:15.471] Timer tick, asking Buildbucket for the build status
[13:32:15.517] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:15.517] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:114:0) after 1m0s
[13:33:15.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:114:0)
[13:33:15.538] Timer tick, asking Buildbucket for the build status
[13:33:15.605] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:15.605] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:115:0) after 1m0s
[13:34:15.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:115:0)
[13:34:15.626] Timer tick, asking Buildbucket for the build status
[13:34:15.805] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:15.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:116:0) after 1m0s
[13:35:15.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:116:0)
[13:35:15.850] Timer tick, asking Buildbucket for the build status
[13:35:15.927] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:15.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:117:0) after 1m0s
[13:36:15.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:117:0)
[13:36:15.951] Timer tick, asking Buildbucket for the build status
[13:36:15.989] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:15.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:118:0) after 1m0s
[13:37:16.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:118:0)
[13:37:16.018] Timer tick, asking Buildbucket for the build status
[13:37:16.083] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:16.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:119:0) after 1m0s
[13:38:16.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:119:0)
[13:38:16.107] Timer tick, asking Buildbucket for the build status
[13:38:16.301] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:16.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:120:0) after 1m0s
[13:39:16.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:120:0)
[13:39:16.328] Timer tick, asking Buildbucket for the build status
[13:39:16.360] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:16.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:121:0) after 1m0s
[13:40:16.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:121:0)
[13:40:16.448] Timer tick, asking Buildbucket for the build status
[13:40:16.551] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:16.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:122:0) after 1m0s
[13:41:16.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:122:0)
[13:41:16.575] Timer tick, asking Buildbucket for the build status
[13:41:16.614] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:16.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:123:0) after 1m0s
[13:42:16.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:123:0)
[13:42:16.638] Timer tick, asking Buildbucket for the build status
[13:42:16.692] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:16.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:124:0) after 1m0s
[13:43:16.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:124:0)
[13:43:16.742] Timer tick, asking Buildbucket for the build status
[13:43:16.790] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:16.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:125:0) after 1m0s
[13:44:16.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:125:0)
[13:44:16.824] Timer tick, asking Buildbucket for the build status
[13:44:16.882] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:16.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:126:0) after 1m0s
[13:45:16.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:126:0)
[13:45:16.973] Timer tick, asking Buildbucket for the build status
[13:45:17.039] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:17.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:127:0) after 1m0s
[13:46:17.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:127:0)
[13:46:17.190] Timer tick, asking Buildbucket for the build status
[13:46:17.264] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:17.264] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:128:0) after 1m0s
[13:47:17.375] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:128:0)
[13:47:17.375] Timer tick, asking Buildbucket for the build status
[13:47:17.472] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:17.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:129:0) after 1m0s
[13:48:17.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:129:0)
[13:48:17.578] Timer tick, asking Buildbucket for the build status
[13:48:17.670] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:17.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:130:0) after 1m0s
[13:49:17.727] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:130:0)
[13:49:17.727] Timer tick, asking Buildbucket for the build status
[13:49:17.799] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:17.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:131:0) after 1m0s
[13:50:17.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:131:0)
[13:50:17.868] Timer tick, asking Buildbucket for the build status
[13:50:17.920] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:17.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:132:0) after 1m0s
[13:51:17.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:132:0)
[13:51:17.943] Timer tick, asking Buildbucket for the build status
[13:51:18.002] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:18.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:133:0) after 1m0s
[13:52:18.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:133:0)
[13:52:18.029] Timer tick, asking Buildbucket for the build status
[13:52:18.125] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:18.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:134:0) after 1m0s
[13:53:18.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:134:0)
[13:53:18.147] Timer tick, asking Buildbucket for the build status
[13:53:18.242] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:18.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:135:0) after 1m0s
[13:54:18.268] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:135:0)
[13:54:18.268] Timer tick, asking Buildbucket for the build status
[13:54:18.359] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:18.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:136:0) after 1m0s
[13:55:18.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:136:0)
[13:55:18.382] Timer tick, asking Buildbucket for the build status
[13:55:18.477] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:18.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:137:0) after 1m0s
[13:56:18.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:137:0)
[13:56:18.499] Timer tick, asking Buildbucket for the build status
[13:56:18.536] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:18.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:138:0) after 1m0s
[13:57:18.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:138:0)
[13:57:18.640] Timer tick, asking Buildbucket for the build status
[13:57:18.673] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:18.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:139:0) after 1m0s
[13:58:18.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:139:0)
[13:58:18.770] Timer tick, asking Buildbucket for the build status
[13:58:18.812] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:18.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:140:0) after 1m0s
[13:59:18.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:140:0)
[13:59:18.842] Timer tick, asking Buildbucket for the build status
[13:59:18.909] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:18.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:141:0) after 1m0s
[14:00:18.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:141:0)
[14:00:18.965] Timer tick, asking Buildbucket for the build status
[14:00:19.039] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:19.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:142:0) after 1m0s
[14:01:19.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:142:0)
[14:01:19.098] Timer tick, asking Buildbucket for the build status
[14:01:19.287] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:19.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:143:0) after 1m0s
[14:02:19.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:143:0)
[14:02:19.310] Timer tick, asking Buildbucket for the build status
[14:02:19.380] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:02:19.380] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:144:0) after 1m0s
[14:03:19.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:144:0)
[14:03:19.403] Timer tick, asking Buildbucket for the build status
[14:03:19.591] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:03:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:145:0) after 1m0s
[14:04:19.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:145:0)
[14:04:19.617] Timer tick, asking Buildbucket for the build status
[14:04:19.696] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:04:19.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:146:0) after 1m0s
[14:05:19.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:146:0)
[14:05:19.766] Timer tick, asking Buildbucket for the build status
[14:05:19.840] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:05:19.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:147:0) after 1m0s
[14:06:19.962] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:147:0)
[14:06:19.962] Timer tick, asking Buildbucket for the build status
[14:06:20.037] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:06:20.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:148:0) after 1m0s
[14:07:20.069] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:148:0)
[14:07:20.069] Timer tick, asking Buildbucket for the build status
[14:07:20.482] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:07:20.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:149:0) after 1m0s
[14:08:20.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:149:0)
[14:08:20.506] Timer tick, asking Buildbucket for the build status
[14:08:20.577] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:08:20.577] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:150:0) after 1m0s
[14:09:20.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:150:0)
[14:09:20.604] Timer tick, asking Buildbucket for the build status
[14:09:20.711] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:09:20.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:151:0) after 1m0s
[14:10:20.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:151:0)
[14:10:20.743] Timer tick, asking Buildbucket for the build status
[14:10:20.794] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:10:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:152:0) after 1m0s
[14:11:20.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:152:0)
[14:11:20.816] Timer tick, asking Buildbucket for the build status
[14:11:20.872] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:11:20.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:153:0) after 1m0s
[14:12:20.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:153:0)
[14:12:20.939] Timer tick, asking Buildbucket for the build status
[14:12:21.013] Build 8932239885189973536: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:12:21.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097669947479358048:154:0) after 1m0s
[14:12:28.430] Received PubSub notification, asking Buildbucket for the build status
[14:12:28.491] Build 8932239885189973536: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:12:28.491] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1539958347381706",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1539949255722937",
"id": "8932239885189973536",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"build_run_result\": {\"infraFailure\": null, \"recipeResult\": {\"jsonResult\": \"null\"}, \"recipeExitCode\": {\"value\": 0}, \"recipe\": {\"name\": \"swarming/deterministic_build\", \"repository\": \"\", \"revision\": \"\"}, \"annotationUrl\": \"logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8932239885189973536/+/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\": [\"3809-a31bbe1\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"integrity\": [\"high\"], \"id\": [\"swarm2173-c4\"], \"pool\": [\"luci.chromium.ci\"], \"caches\": [\"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25264}\", \"$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@{#601115}\", \"branch\": \"refs/heads/master\", \"revision\": \"e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"2461c319ed087e7dcac636feb61cd9343d1b6c1b\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"bc6f52f36d5f1a4046f93182522b65cec43bcae3\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1539949255722937, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097669947479358048\", \"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\": \"8932239885189973536\"}}, \"got_v8_revision\": \"ea3778620fd9053bc9b26223daf874477e5c2420\", \"got_v8_revision_cp\": \"refs/heads/7.2.43@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10450, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"0b00923826a6af80ea4f3c3c0f0432ff28d9a0a2\", \"notification_helper_unittests\": \"2da9eed47f24c2b02854d21fd8066b6afbbed0db\", \"gpu_perftests\": \"10ac3513e2c90e7423bc1e1469a995c25fb9abf0\", \"vr_common_unittests\": \"b0a486a6470d1a7aabf8be4a9c7c58adb605e8ee\", \"telemetry_unittests\": \"ef960fdc8f6592da2075a6a19eb2bcdf37922d0d\", \"load_library_perf_tests\": \"eeb917ca35d6fbb90df72af19bfbde586f77a444\", \"devtools_closure_compile\": \"e4e56ecf341b99135722ee7f746bdcee8d980454\", \"chromedriver_py_tests\": \"6ac55eb1ee2d258d272555a2e3a59de9ebce4856\", \"mojo_core_unittests\": \"14102c3a29426d8c80aad41eefc71da3622c98af\", \"install_static_unittests\": \"4d21c2f38fb0317ec85e9adb625644c1bcd0f6d4\", \"leveldb_service_unittests\": \"bdcca4935ddd93cd74a80fc64e2693d0eeb6cf2f\", \"mini_installer_tests\": \"3a36e5aa136fd885411071acb64b30dabf76c9a1\", \"gcp_unittests\": \"f9877a59b9c4a8539e282eaf115441a259fc536d\", \"sbox_integration_tests\": \"b2cf4993e6c5c9537d57e0a519577199f65825e9\", \"angle_unittests\": \"009e106fad04595d8cdc73c85704cbf492edb2d7\", \"cast_unittests\": \"b22178b44be1dd0db5be9e0ea2d2f266db9bab93\", \"cc_unittests\": \"3878a1ff8aba019e19d5d3fec3f7344dfb241804\", \"blink_common_unittests\": \"22af81e8a29f1e20d33b9dbc892dd39c711a1585\", \"crashpad_tests\": \"bcf22be286970db73665928da2518b97a70849b3\", \"telemetry_perf_tests_without_chrome\": \"1e45c44774418e491dfee18315310a3c3657b9d3\", \"metrics_python_tests\": \"57ae1b2f18107bc36737c39c3d9a6a6fcc176218\", \"message_center_unittests\": \"8d8501c7eeaea5fb8b132128e6e611d89d37025b\", \"ppapi_unittests\": \"7bfda6e8c06a321bdfb0c0dbe796cf678461ffe9\", \"extensions_unittests\": \"fd7a84d14ed4e5276764fbb9a74b48de27775ac0\", \"gl_unittests_ozone\": \"88ec8c3a14cc034f614b5970d29c8575d4f2eae7\", \"app_shell_unittests\": \"36779c8d40d8e68c9a30431bc77580bbd2932d72\", \"chrome_app_unittests\": \"81106353e09962e3fbb92e99955e1ff61a0e9599\", \"gl_unittests\": \"88ec8c3a14cc034f614b5970d29c8575d4f2eae7\", \"gcm_unit_tests\": \"b8caaafb72fead1a78b86332d32c843960ed0dc5\", \"views_unittests\": \"7e5a12cac0559c966f4ed6d2275da93af37b0265\", \"content_shell_crash_test\": \"2250165a374379b48348bb69c200ec7084230224\", \"ui_base_unittests\": \"bd6a843d44879c033d1b80f09d15fea88ccdee28\", \"cronet_unittests\": \"58359ccd69da7b2d8957e28ce89a65940f84a9be\", \"performance_test_suite\": \"3b344a5fc93f76917da4c965ef72a491badb7023\", \"wm_unittests\": \"0ae989697a5ad64bc10d05e4a64326fcd82cca61\", \"boringssl_crypto_tests\": \"d61a4a157efd329e5040619b9f64392d08af222f\", \"gin_unittests\": \"67a06dca0a6b8daa5082b04accc0ab97e8c8ffb3\", \"performance_browser_tests\": \"bf2f7cab911fc02a37678f73fa5fce294d41cb3e\", \"extensions_browsertests\": \"9c0967516c2c409cd66d4227d8f958dacb6ddd5f\", \"webkit_python_tests\": \"bfb4065586e190c03ea1deaf5a0b692118643886\", \"headless_unittests\": \"6859a0079365d7cacbfbe87b41e0c0ff0c01a19a\", \"webkit_layout_tests\": \"a907e9f9ab919a6111fe7ac3e4fcb94198027802\", \"vr_pixeltests\": \"965b272557ddda8fc08efa51a12357bdcd66e4a2\", \"setup_unittests\": \"d267203cf03cb5f11a91b5b6e5cfe41b448ca623\", \"webkit_unit_tests\": \"0adcd5c785568eeacec7bf51c43487c6116c2e8b\", \"content_unittests\": \"45a11be37b50950cdc626dd998329d70ee19cd17\", \"performance_webview_test_suite\": \"215b83b80bb0a146804c0fac0ce60032fcebf8c3\", \"wtf_unittests\": \"d69ff8e13c35f9cfff2c21635f3a0c0b9c727e07\", \"webkit_layout_tests_exparchive\": \"c3b1e70cba60e0bbf9501802c16b11dd6afa709b\", \"chrome_cleaner_unittests\": \"4c83bcfdf1590acdab692ba91c2f2c2011f3fd8d\", \"traffic_annotation_auditor_unittests\": \"18cfe5ba0c3100e1a850fd11de2ad631c3ba2b7a\", \"libjingle_xmpp_unittests\": \"245a5a8e20d887d3dcfae11f76c74865a7b3b1ad\", \"remoting_unittests\": \"8e82670c5ba9a97629c53a79ea4dde0fc63f9985\", \"vr_common_perftests\": \"069252880ec078275ff9e7287a70cee023341345\", \"filesystem_service_unittests\": \"5b6e9baf30b5063ccaf7886612cad5f226e824f7\", \"chrome_elf_import_unittests\": \"bc6edcbd1e6c52ba8993030b4e929c572286b3ad\", \"installer_util_unittests\": \"fcfe8f8d25457b28b8d60ed10bef9cb7f720ac58\", \"gfx_unittests\": \"fff775c8b3485e4aa5bfce9c3acc642be10a25ea\", \"headless_browsertests\": \"9790be4ac8c501c440cdad117b92ae550d8f8df0\", \"capture_unittests\": \"b10f3e760f6c8ab2360d1e219a6f622801f8df60\", \"chrome_elf_unittests\": \"2ec7ccb4e5c60f2807b9605661708330a33be868\", \"telemetry_gpu_unittests\": \"a9535b8088968a5ab846fc0fa510dd8ff08eae37\", \"command_buffer_perftests\": \"3865f0ff96204e4cd249ed1c682d68f78aeece2c\", \"media_unittests\": \"94a42c1d3ff959b66003cec031e35fc1d3e2f9c7\", \"chromedriver_unittests\": \"e0fc07ed15a8e291f2282cb0f39b4f0988803de6\", \"views_mus_interactive_ui_tests\": \"ee77628f48e656dca5c7a86c927c9296f9369ed6\", \"storage_unittests\": \"83acfe8ce0cd551e121fc72cd934a21ba3f67db5\", \"media_service_unittests\": \"e0cb66125ac6363271d3e8830af646202c6e61fe\", \"compositor_unittests\": \"13071bb2a9b418c5bff612e9a4d13bbd41ae8d4a\", \"latency_unittests\": \"b23b663aa903a83d928128dfa9fac7eb1d77f2ac\", \"video_decode_accelerator_unittest\": \"c5da91cb433a60c5e6aa1c0495a490ae94741fc4\", \"swiftshader_unittests\": \"071f855c19f7563670d5094203686522cbdbdb24\", \"telemetry_perf_unittests\": \"eadfe8f817a2ea447cb5d7dfe7e24eab729c615b\", \"media_blink_unittests\": \"6a884038ae8c04e92d41f7462060ea02ef5ddba7\", \"views_mus_unittests\": \"b43c4e0c656aab8007569cc7110f1499555507b2\", \"components_unittests\": \"c120383e0d262d8501f9cb2434fdc8ec23106f8b\", \"snapshot_unittests\": \"30361abb985d685f4fb136600bd5a960564bef0a\", \"accessibility_unittests\": \"3b3f6db2d268fd7c28886a9a92efe280ba894ba0\", \"net_perftests\": \"0181e0534a1f4ebe327dc74884431f63b61c8e78\", \"aura_unittests\": \"6b32a9e299a0328ce37661707ea8f371daf6b239\", \"services_unittests\": \"0cb3207df3d08e2455a710deb69ab2b0c9b58d2f\", \"components_perftests\": \"ff029874f3bbd9d8a01dbb792cf523f13b5948ad\", \"events_unittests\": \"8d14d44e6d9b6592d6ab2740b5e0e07aa5452b35\", \"tracing_perftests\": \"22a0e38741d21510bd37a2239b91efe92d791ebe\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"3b12a460989222d63721247b226d8976af0b9c43\", \"cacheinvalidation_unittests\": \"531b732099ee3d340e139da295c4d18f1401c57b\", \"viz_unittests\": \"2ec7fb42c986f3705f61b34bdfb5ea9668e0b213\", \"browser_tests\": \"5b3a7ed6eb9855badbda8aac9117a70a23c6c13e\", \"net_unittests\": \"8055f5d6fc751f905262839e7c84c465a2bffc21\", \"pdf_unittests\": \"88d3fa97fee7dc6354f6972cb0186a320510f285\", \"boringssl_ssl_tests\": \"acc9a651b7d83ee19508e85e5585836f4580bff9\", \"sbox_validation_tests\": \"154b62dc4b6d863dc98608adf57516630187522b\", \"elevation_service_unittests\": \"2fc713c2041c2a12f4a2c1d916d742c9e9113810\", \"gpu_unittests\": \"01a25b952db6d4666140c82283fd355718ce92a8\", \"native_theme_unittests\": \"b5673eab071f2dcaa1eff90f25579fb177d1fd13\", \"interactive_ui_tests\": \"3275fc497235320eecc24af79464005f410ff896\", \"mojo_unittests\": \"fd0abf6cdf37b94eef6fc67339201b145a8a6702\", \"url_unittests\": \"efee95bccdc6c1cfda3e05c2a1ac938dd65e62b6\", \"media_perftests\": \"84c64bf27f19798b42287c7fe61363d957070431\", \"cronet_tests\": \"14982337294a05cf4f1db796e414722d2d0202a7\", \"google_apis_unittests\": \"badd5584e4e366d35bd2b7b175d0d7c700e30516\", \"telemetry_gpu_integration_test\": \"84bd3f4d2f4dd72cec910abf4841ff089648941a\", \"blink_heap_unittests\": \"1ee837e53cd55793952755f9f9b560b44e83b89d\", \"midi_unittests\": \"81b4369c18d1dc2cada802dd57c3d58ba21b968f\", \"base_unittests\": \"5b4592dbf20a4c87608e87396a39cc09066424f0\", \"sync_integration_tests\": \"53b258a31dcfe2ac26c4cfd13b0f90faba1cc746\", \"sql_unittests\": \"2348adaf33359e634e28c4845d89eee8accb0e8a\", \"courgette_unittests\": \"f43dfeefd2ea7bcb5847a92a5956b42a07afda27\", \"blink_fuzzer_unittests\": \"48b30d45e7f7cf869d8b1b9d75bbfb4773675d24\", \"gl_tests\": \"610fff89b5c66e9df05b95de9b40ea53347a43a4\", \"zucchini_unittests\": \"6cb05de7ccb1e76617b649c595e284f59aa4bb2c\", \"ipc_tests\": \"5ceabf7d5c4ef8618ec709423051ce247f87c52f\", \"angle_end2end_tests\": \"108e03a33d7a27ace6157be88c17a7fd157f9a34\", \"blink_platform_unittests\": \"44f9db06bd7a2b57991e8e0f8db600b0acecb8c9\", \"components_browsertests\": \"1a79e0d4cc76bb89d00ca1d585ccf8fcd9fafc43\", \"views_perftests\": \"d055b70717788d631a5a0626f72e363fcec9b9e1\", \"angle_perftests\": \"82c20769fb66ffb413cb4b3c30e0f5d212c0b125\", \"display_unittests\": \"ad10aeb5489c9d9f5456f8897c0a6b9be7e26bc7\", \"sbox_unittests\": \"944a716e0473ba78f1374a90db6022a5816d3b46\", \"service_manager_unittests\": \"f8cdcceba9e97f5e081122f95b914e4979f3e019\", \"gles2_conform_test\": \"47217cbdb710396e5f4a8f6325d27534b698d5ff\", \"jingle_unittests\": \"a0b3ad5548e8ab370cc096dc617564a4862befb5\", \"skia_unittests\": \"6d011c9d459e35113d0764d2647a44fd533d6db3\", \"angle_white_box_tests\": \"8caccb8f0f9fc3e9e6bdd83709f528b6c8a4f143\", \"crypto_unittests\": \"d6e039b0835fdbabba7de83b2d67dc0d68e4d4af\", \"nacl_loader_unittests\": \"6297d536e1d87b200d61a582142ce7abc0618646\", \"unit_tests\": \"3f17d24ebfc76bf7308f58603e954ad3b6b9656f\", \"content_browsertests\": \"1d01f2b7488fd49fe7d75a53b38bf1d57c248a64\", \"printing_unittests\": \"109c8dbbfec59482f115fe3cd4ec13a8cc6fa922\", \"device_unittests\": \"cc7cf94f427da963a4b1032ac31ec6c72aa212fb\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1539949258471825",
"status": "COMPLETED",
"status_changed_ts": "1539958347979425",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10450",
"builder:Windows deterministic",
"buildset:commit/git/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097669947479358048",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_dimension:builder:Windows deterministic",
"swarming_dimension:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_dimension:cores:8",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Windows-10",
"swarming_dimension:pool:luci.chromium.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.chromium.ci/Windows deterministic/10450",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932239885189973536",
"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/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e799b8820e2bc5eb78aa6a08fdbb2ab22749a9e4",
"swarming_tag:caches:builder_d795d6e07fe37a299fcfc0e872e48757ad306282f024125f803c0465bfd1eeae_v2",
"swarming_tag:cores:8",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8932239885189973536/+/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:9097669947479358048",
"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:86f8743ced46ac7ae8a49d5f70eecbcfd17feac4",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40a4f2688c051810",
"user_agent:luci-scheduler"
],
"updated_ts": "1539958347981034",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10450",
"utcnow_ts": "1539958348469268"
}
}
[14:12:28.491] Invocation finished in 2h31m34.336418563s with status SUCCEEDED