[20:27:16.438] New invocation is queued and will start shortly
[20:27:17.667] Starting the invocation (attempt 1)
[20:27:17.704] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:27:17.704] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:27:17.704] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9097455637138741232",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"a93d048f9be00cdd061bdf6db4f512dd4beee34d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9097455637138741232",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"gitiles_ref:refs/heads/master"
]
}
[20:27:19.457] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540153637785534",
"id": "8932025575063954272",
"lease_expiration_ts": "1540297639224870",
"lease_key": "1288782284",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a93d048f9be00cdd061bdf6db4f512dd4beee34d\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1540153639370161",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10465",
"builder:Windows deterministic",
"buildset:commit/git/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097455637138741232",
"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/10465",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932025575063954272",
"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/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"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/8932025575063954272/+/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:9097455637138741232",
"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:5d21b61d8922783e1f86e64740632e2a34b9be92",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40b1210840f54b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540153639370259",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10465",
"utcnow_ts": "1540153639446156"
}
}
[20:27:19.457] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10465
[20:27:19.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:2:0) after 1m0s
[20:28:19.474] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:2:0)
[20:28:19.474] Timer tick, asking Buildbucket for the build status
[20:28:19.641] Build 8932025575063954272: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:28:19.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:3:0) after 1m0s
[20:29:02.628] Received PubSub notification, asking Buildbucket for the build status
[20:29:02.767] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:3:0)
[20:29:19.660] Timer tick, asking Buildbucket for the build status
[20:29:19.764] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:19.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:5:0) after 1m0s
[20:30:19.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:5:0)
[20:30:19.782] Timer tick, asking Buildbucket for the build status
[20:30:19.907] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:19.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:6:0) after 1m0s
[20:31:19.924] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:6:0)
[20:31:19.924] Timer tick, asking Buildbucket for the build status
[20:31:20.127] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:20.127] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:7:0) after 1m0s
[20:32:20.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:7:0)
[20:32:20.204] Timer tick, asking Buildbucket for the build status
[20:32:20.338] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:20.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:8:0) after 1m0s
[20:33:20.355] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:8:0)
[20:33:20.355] Timer tick, asking Buildbucket for the build status
[20:33:20.449] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:20.449] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:9:0) after 1m0s
[20:34:20.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:9:0)
[20:34:20.469] Timer tick, asking Buildbucket for the build status
[20:34:20.513] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:20.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:10:0) after 1m0s
[20:35:20.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:10:0)
[20:35:20.535] Timer tick, asking Buildbucket for the build status
[20:35:20.596] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:20.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:11:0) after 1m0s
[20:36:20.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:11:0)
[20:36:20.615] Timer tick, asking Buildbucket for the build status
[20:36:20.683] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:20.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:12:0) after 1m0s
[20:37:20.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:12:0)
[20:37:20.701] Timer tick, asking Buildbucket for the build status
[20:37:20.897] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:20.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:13:0) after 1m0s
[20:38:20.915] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:13:0)
[20:38:20.915] Timer tick, asking Buildbucket for the build status
[20:38:21.031] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:21.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:14:0) after 1m0s
[20:39:21.055] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:14:0)
[20:39:21.055] Timer tick, asking Buildbucket for the build status
[20:39:21.177] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:21.177] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:15:0) after 1m0s
[20:40:21.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:15:0)
[20:40:21.233] Timer tick, asking Buildbucket for the build status
[20:40:21.313] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:21.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:16:0) after 1m0s
[20:41:21.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:16:0)
[20:41:21.348] Timer tick, asking Buildbucket for the build status
[20:41:21.425] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:21.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:17:0) after 1m0s
[20:42:21.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:17:0)
[20:42:21.447] Timer tick, asking Buildbucket for the build status
[20:42:21.604] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:21.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:18:0) after 1m0s
[20:43:21.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:18:0)
[20:43:21.638] Timer tick, asking Buildbucket for the build status
[20:43:21.687] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:21.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:19:0) after 1m0s
[20:44:21.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:19:0)
[20:44:21.718] Timer tick, asking Buildbucket for the build status
[20:44:21.837] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:21.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:20:0) after 1m0s
[20:45:21.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:20:0)
[20:45:21.858] Timer tick, asking Buildbucket for the build status
[20:45:21.913] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:21.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:21:0) after 1m0s
[20:46:21.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:21:0)
[20:46:21.938] Timer tick, asking Buildbucket for the build status
[20:46:22.146] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:22.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:22:0) after 1m0s
[20:47:22.208] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:22:0)
[20:47:22.208] Timer tick, asking Buildbucket for the build status
[20:47:22.338] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:22.338] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:23:0) after 1m0s
[20:48:22.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:23:0)
[20:48:22.356] Timer tick, asking Buildbucket for the build status
[20:48:22.437] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:22.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:24:0) after 1m0s
[20:49:22.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:24:0)
[20:49:22.457] Timer tick, asking Buildbucket for the build status
[20:49:22.566] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:22.566] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:25:0) after 1m0s
[20:50:22.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:25:0)
[20:50:22.585] Timer tick, asking Buildbucket for the build status
[20:50:22.668] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:22.668] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:26:0) after 1m0s
[20:51:22.684] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:26:0)
[20:51:22.684] Timer tick, asking Buildbucket for the build status
[20:51:22.803] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:22.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:27:0) after 1m0s
[20:52:22.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:27:0)
[20:52:22.822] Timer tick, asking Buildbucket for the build status
[20:52:22.975] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:22.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:28:0) after 1m0s
[20:53:22.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:28:0)
[20:53:22.994] Timer tick, asking Buildbucket for the build status
[20:53:23.030] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:23.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:29:0) after 1m0s
[20:54:23.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:29:0)
[20:54:23.047] Timer tick, asking Buildbucket for the build status
[20:54:23.224] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:23.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:30:0) after 1m0s
[20:55:23.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:30:0)
[20:55:23.258] Timer tick, asking Buildbucket for the build status
[20:55:23.336] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:23.336] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:31:0) after 1m0s
[20:56:23.353] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:31:0)
[20:56:23.353] Timer tick, asking Buildbucket for the build status
[20:56:23.447] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:23.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:32:0) after 1m0s
[20:57:23.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:32:0)
[20:57:23.463] Timer tick, asking Buildbucket for the build status
[20:57:23.531] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:23.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:33:0) after 1m0s
[20:58:23.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:33:0)
[20:58:23.556] Timer tick, asking Buildbucket for the build status
[20:58:23.663] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:23.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:34:0) after 1m0s
[20:59:23.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:34:0)
[20:59:23.681] Timer tick, asking Buildbucket for the build status
[20:59:23.825] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:23.825] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:35:0) after 1m0s
[21:00:23.858] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:35:0)
[21:00:23.858] Timer tick, asking Buildbucket for the build status
[21:00:24.030] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:24.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:36:0) after 1m0s
[21:01:24.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:36:0)
[21:01:24.076] Timer tick, asking Buildbucket for the build status
[21:01:24.241] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:24.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:37:0) after 1m0s
[21:02:24.316] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:37:0)
[21:02:24.316] Timer tick, asking Buildbucket for the build status
[21:02:24.425] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:24.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:38:0) after 1m0s
[21:03:24.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:38:0)
[21:03:24.520] Timer tick, asking Buildbucket for the build status
[21:03:24.632] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:39:0) after 1m0s
[21:04:24.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:39:0)
[21:04:24.650] Timer tick, asking Buildbucket for the build status
[21:04:24.704] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:24.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:40:0) after 1m0s
[21:05:24.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:40:0)
[21:05:24.726] Timer tick, asking Buildbucket for the build status
[21:05:24.847] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:24.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:41:0) after 1m0s
[21:06:24.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:41:0)
[21:06:24.911] Timer tick, asking Buildbucket for the build status
[21:06:25.221] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:25.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:42:0) after 1m0s
[21:07:25.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:42:0)
[21:07:25.363] Timer tick, asking Buildbucket for the build status
[21:07:25.422] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:25.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:43:0) after 1m0s
[21:08:25.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:43:0)
[21:08:25.437] Timer tick, asking Buildbucket for the build status
[21:08:25.508] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:25.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:44:0) after 1m0s
[21:09:25.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:44:0)
[21:09:25.524] Timer tick, asking Buildbucket for the build status
[21:09:25.562] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:45:0) after 1m0s
[21:10:25.635] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:45:0)
[21:10:25.635] Timer tick, asking Buildbucket for the build status
[21:10:25.868] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:25.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:46:0) after 1m0s
[21:11:25.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:46:0)
[21:11:25.886] Timer tick, asking Buildbucket for the build status
[21:11:26.080] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:26.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:47:0) after 1m0s
[21:12:26.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:47:0)
[21:12:26.123] Timer tick, asking Buildbucket for the build status
[21:12:26.183] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:26.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:48:0) after 1m0s
[21:13:26.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:48:0)
[21:13:26.308] Timer tick, asking Buildbucket for the build status
[21:13:26.382] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:26.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:49:0) after 1m0s
[21:14:26.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:49:0)
[21:14:26.408] Timer tick, asking Buildbucket for the build status
[21:14:26.462] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:26.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:50:0) after 1m0s
[21:15:26.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:50:0)
[21:15:26.508] Timer tick, asking Buildbucket for the build status
[21:15:26.649] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:26.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:51:0) after 1m0s
[21:16:26.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:51:0)
[21:16:26.694] Timer tick, asking Buildbucket for the build status
[21:16:26.804] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:26.804] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:52:0) after 1m0s
[21:17:26.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:52:0)
[21:17:26.940] Timer tick, asking Buildbucket for the build status
[21:17:27.002] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:27.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:53:0) after 1m0s
[21:18:27.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:53:0)
[21:18:27.025] Timer tick, asking Buildbucket for the build status
[21:18:27.134] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:27.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:54:0) after 1m0s
[21:19:27.209] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:54:0)
[21:19:27.209] Timer tick, asking Buildbucket for the build status
[21:19:27.267] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:27.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:55:0) after 1m0s
[21:20:27.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:55:0)
[21:20:27.286] Timer tick, asking Buildbucket for the build status
[21:20:27.349] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:27.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:56:0) after 1m0s
[21:21:27.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:56:0)
[21:21:27.407] Timer tick, asking Buildbucket for the build status
[21:21:27.690] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:27.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:57:0) after 1m0s
[21:22:27.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:57:0)
[21:22:27.710] Timer tick, asking Buildbucket for the build status
[21:22:27.794] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:27.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:58:0) after 1m0s
[21:23:27.895] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:58:0)
[21:23:27.895] Timer tick, asking Buildbucket for the build status
[21:23:27.965] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:27.965] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:59:0) after 1m0s
[21:24:28.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:59:0)
[21:24:28.001] Timer tick, asking Buildbucket for the build status
[21:24:28.060] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:28.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:60:0) after 1m0s
[21:25:28.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:60:0)
[21:25:28.298] Timer tick, asking Buildbucket for the build status
[21:25:28.382] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:28.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:61:0) after 1m0s
[21:26:28.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:61:0)
[21:26:28.541] Timer tick, asking Buildbucket for the build status
[21:26:28.662] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:28.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:62:0) after 1m0s
[21:27:29.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:62:0)
[21:27:29.213] Timer tick, asking Buildbucket for the build status
[21:27:29.324] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:29.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:63:0) after 1m0s
[21:28:30.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:63:0)
[21:28:30.112] Timer tick, asking Buildbucket for the build status
[21:28:30.205] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:30.205] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:64:0) after 1m0s
[21:29:30.273] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:64:0)
[21:29:30.273] Timer tick, asking Buildbucket for the build status
[21:29:30.396] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:30.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:65:0) after 1m0s
[21:30:30.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:65:0)
[21:30:30.701] Timer tick, asking Buildbucket for the build status
[21:30:30.824] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:30.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:66:0) after 1m0s
[21:31:31.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:66:0)
[21:31:31.105] Timer tick, asking Buildbucket for the build status
[21:31:31.254] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:31.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:67:0) after 1m0s
[21:32:31.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:67:0)
[21:32:31.894] Timer tick, asking Buildbucket for the build status
[21:32:31.959] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:31.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:68:0) after 1m0s
[21:33:32.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:68:0)
[21:33:32.561] Timer tick, asking Buildbucket for the build status
[21:33:32.683] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:32.683] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:69:0) after 1m0s
[21:34:33.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:69:0)
[21:34:33.385] Timer tick, asking Buildbucket for the build status
[21:34:33.491] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:33.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:70:0) after 1m0s
[21:35:33.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:70:0)
[21:35:33.705] Timer tick, asking Buildbucket for the build status
[21:35:33.793] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:33.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:71:0) after 1m0s
[21:36:34.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:71:0)
[21:36:34.331] Timer tick, asking Buildbucket for the build status
[21:36:34.407] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:34.407] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:72:0) after 1m0s
[21:37:34.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:72:0)
[21:37:34.930] Timer tick, asking Buildbucket for the build status
[21:37:34.995] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:34.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:73:0) after 1m0s
[21:38:35.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:73:0)
[21:38:35.439] Timer tick, asking Buildbucket for the build status
[21:38:35.902] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:35.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:74:0) after 1m0s
[21:39:36.301] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:74:0)
[21:39:36.301] Timer tick, asking Buildbucket for the build status
[21:39:36.363] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:36.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:75:0) after 1m0s
[21:40:36.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:75:0)
[21:40:36.756] Timer tick, asking Buildbucket for the build status
[21:40:36.854] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:36.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:76:0) after 1m0s
[21:41:37.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:76:0)
[21:41:37.010] Timer tick, asking Buildbucket for the build status
[21:41:37.053] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:37.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:77:0) after 1m0s
[21:42:37.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:77:0)
[21:42:37.524] Timer tick, asking Buildbucket for the build status
[21:42:37.581] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:37.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:78:0) after 1m0s
[21:43:37.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:78:0)
[21:43:37.626] Timer tick, asking Buildbucket for the build status
[21:43:37.824] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:37.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:79:0) after 1m0s
[21:44:37.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:79:0)
[21:44:37.916] Timer tick, asking Buildbucket for the build status
[21:44:38.009] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:38.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:80:0) after 1m0s
[21:45:38.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:80:0)
[21:45:38.034] Timer tick, asking Buildbucket for the build status
[21:45:38.094] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:38.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:81:0) after 1m0s
[21:46:38.221] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:81:0)
[21:46:38.221] Timer tick, asking Buildbucket for the build status
[21:46:38.304] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:38.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:82:0) after 1m0s
[21:47:38.612] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:82:0)
[21:47:38.612] Timer tick, asking Buildbucket for the build status
[21:47:38.691] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:38.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:83:0) after 1m0s
[21:48:39.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:83:0)
[21:48:39.137] Timer tick, asking Buildbucket for the build status
[21:48:39.244] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:39.244] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:84:0) after 1m0s
[21:49:39.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:84:0)
[21:49:39.264] Timer tick, asking Buildbucket for the build status
[21:49:39.465] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:39.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:85:0) after 1m0s
[21:50:39.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:85:0)
[21:50:39.547] Timer tick, asking Buildbucket for the build status
[21:50:39.763] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:39.763] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:86:0) after 1m0s
[21:51:39.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:86:0)
[21:51:39.872] Timer tick, asking Buildbucket for the build status
[21:51:39.950] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:39.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:87:0) after 1m0s
[21:52:39.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:87:0)
[21:52:39.969] Timer tick, asking Buildbucket for the build status
[21:52:40.036] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:40.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:88:0) after 1m0s
[21:53:40.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:88:0)
[21:53:40.074] Timer tick, asking Buildbucket for the build status
[21:53:40.142] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:40.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:89:0) after 1m0s
[21:54:40.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:89:0)
[21:54:40.622] Timer tick, asking Buildbucket for the build status
[21:54:40.725] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:40.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:90:0) after 1m0s
[21:55:41.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:90:0)
[21:55:41.075] Timer tick, asking Buildbucket for the build status
[21:55:41.153] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:41.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:91:0) after 1m0s
[21:56:41.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:91:0)
[21:56:41.580] Timer tick, asking Buildbucket for the build status
[21:56:41.655] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:41.655] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:92:0) after 1m0s
[21:57:42.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:92:0)
[21:57:42.035] Timer tick, asking Buildbucket for the build status
[21:57:42.100] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:42.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:93:0) after 1m0s
[21:58:42.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:93:0)
[21:58:42.287] Timer tick, asking Buildbucket for the build status
[21:58:42.326] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:42.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:94:0) after 1m0s
[21:59:42.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:94:0)
[21:59:42.392] Timer tick, asking Buildbucket for the build status
[21:59:42.661] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:42.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:95:0) after 1m0s
[22:00:43.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:95:0)
[22:00:43.011] Timer tick, asking Buildbucket for the build status
[22:00:43.076] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:43.076] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:96:0) after 1m0s
[22:01:43.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:96:0)
[22:01:43.446] Timer tick, asking Buildbucket for the build status
[22:01:43.725] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:43.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:97:0) after 1m0s
[22:02:44.110] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:97:0)
[22:02:44.110] Timer tick, asking Buildbucket for the build status
[22:02:44.157] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:44.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:98:0) after 1m0s
[22:03:44.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:98:0)
[22:03:44.469] Timer tick, asking Buildbucket for the build status
[22:03:44.534] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:44.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:99:0) after 1m0s
[22:04:44.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:99:0)
[22:04:44.620] Timer tick, asking Buildbucket for the build status
[22:04:44.701] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:44.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:100:0) after 1m0s
[22:05:44.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:100:0)
[22:05:44.734] Timer tick, asking Buildbucket for the build status
[22:05:44.850] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:44.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:101:0) after 1m0s
[22:06:44.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:101:0)
[22:06:44.926] Timer tick, asking Buildbucket for the build status
[22:06:45.018] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:45.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:102:0) after 1m0s
[22:07:45.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:102:0)
[22:07:45.038] Timer tick, asking Buildbucket for the build status
[22:07:45.156] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:45.156] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:103:0) after 1m0s
[22:08:45.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:103:0)
[22:08:45.439] Timer tick, asking Buildbucket for the build status
[22:08:45.538] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:45.538] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:104:0) after 1m0s
[22:09:45.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:104:0)
[22:09:45.944] Timer tick, asking Buildbucket for the build status
[22:09:47.329] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:47.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:105:0) after 1m0s
[22:10:47.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:105:0)
[22:10:47.658] Timer tick, asking Buildbucket for the build status
[22:10:47.736] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:47.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:106:0) after 1m0s
[22:11:48.111] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:106:0)
[22:11:48.111] Timer tick, asking Buildbucket for the build status
[22:11:48.213] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:48.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:107:0) after 1m0s
[22:12:48.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:107:0)
[22:12:48.308] Timer tick, asking Buildbucket for the build status
[22:12:48.406] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:48.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:108:0) after 1m0s
[22:13:48.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:108:0)
[22:13:48.905] Timer tick, asking Buildbucket for the build status
[22:13:49.104] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:49.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:109:0) after 1m0s
[22:14:49.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:109:0)
[22:14:49.554] Timer tick, asking Buildbucket for the build status
[22:14:49.809] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:49.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:110:0) after 1m0s
[22:15:50.260] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:110:0)
[22:15:50.260] Timer tick, asking Buildbucket for the build status
[22:15:50.411] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:50.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:111:0) after 1m0s
[22:16:50.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:111:0)
[22:16:50.718] Timer tick, asking Buildbucket for the build status
[22:16:50.827] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:50.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:112:0) after 1m0s
[22:17:50.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:112:0)
[22:17:50.907] Timer tick, asking Buildbucket for the build status
[22:17:50.981] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:50.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:113:0) after 1m0s
[22:18:51.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:113:0)
[22:18:51.356] Timer tick, asking Buildbucket for the build status
[22:18:51.425] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:51.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:114:0) after 1m0s
[22:19:51.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:114:0)
[22:19:51.907] Timer tick, asking Buildbucket for the build status
[22:19:52.097] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:52.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:115:0) after 1m0s
[22:20:52.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:115:0)
[22:20:52.318] Timer tick, asking Buildbucket for the build status
[22:20:52.401] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:52.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:116:0) after 1m0s
[22:21:52.728] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:116:0)
[22:21:52.728] Timer tick, asking Buildbucket for the build status
[22:21:52.950] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:52.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:117:0) after 1m0s
[22:22:53.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:117:0)
[22:22:53.217] Timer tick, asking Buildbucket for the build status
[22:22:53.410] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:118:0) after 1m0s
[22:23:53.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:118:0)
[22:23:53.860] Timer tick, asking Buildbucket for the build status
[22:23:53.927] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:53.927] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:119:0) after 1m0s
[22:24:54.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:119:0)
[22:24:54.377] Timer tick, asking Buildbucket for the build status
[22:24:54.454] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:54.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:120:0) after 1m0s
[22:25:55.001] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:120:0)
[22:25:55.001] Timer tick, asking Buildbucket for the build status
[22:25:55.197] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:55.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:121:0) after 1m0s
[22:26:55.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:121:0)
[22:26:55.478] Timer tick, asking Buildbucket for the build status
[22:26:55.595] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:55.595] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:122:0) after 1m0s
[22:27:55.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:122:0)
[22:27:55.840] Timer tick, asking Buildbucket for the build status
[22:27:55.920] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:55.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:123:0) after 1m0s
[22:28:56.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:123:0)
[22:28:56.269] Timer tick, asking Buildbucket for the build status
[22:28:56.316] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:56.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:124:0) after 1m0s
[22:29:56.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:124:0)
[22:29:56.866] Timer tick, asking Buildbucket for the build status
[22:29:56.954] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:56.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:125:0) after 1m0s
[22:30:57.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:125:0)
[22:30:57.465] Timer tick, asking Buildbucket for the build status
[22:30:57.568] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:57.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:126:0) after 1m0s
[22:31:57.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:126:0)
[22:31:57.602] Timer tick, asking Buildbucket for the build status
[22:31:57.687] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:57.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:127:0) after 1m0s
[22:32:58.158] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:127:0)
[22:32:58.158] Timer tick, asking Buildbucket for the build status
[22:32:58.375] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:58.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:128:0) after 1m0s
[22:33:58.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:128:0)
[22:33:58.703] Timer tick, asking Buildbucket for the build status
[22:33:58.802] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:58.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:129:0) after 1m0s
[22:34:59.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:129:0)
[22:34:59.159] Timer tick, asking Buildbucket for the build status
[22:34:59.220] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:59.220] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:130:0) after 1m0s
[22:35:59.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:130:0)
[22:35:59.811] Timer tick, asking Buildbucket for the build status
[22:35:59.910] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:59.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:131:0) after 1m0s
[22:37:00.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:131:0)
[22:37:00.453] Timer tick, asking Buildbucket for the build status
[22:37:00.533] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:00.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:132:0) after 1m0s
[22:38:01.201] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:132:0)
[22:38:01.201] Timer tick, asking Buildbucket for the build status
[22:38:02.312] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:02.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:133:0) after 1m0s
[22:39:02.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:133:0)
[22:39:02.872] Timer tick, asking Buildbucket for the build status
[22:39:02.958] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:02.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:134:0) after 1m0s
[22:40:03.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:134:0)
[22:40:03.411] Timer tick, asking Buildbucket for the build status
[22:40:03.503] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:03.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:135:0) after 1m0s
[22:41:03.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:135:0)
[22:41:03.822] Timer tick, asking Buildbucket for the build status
[22:41:04.095] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:04.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:136:0) after 1m0s
[22:42:04.509] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:136:0)
[22:42:04.509] Timer tick, asking Buildbucket for the build status
[22:42:04.604] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:04.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:137:0) after 1m0s
[22:43:05.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:137:0)
[22:43:05.057] Timer tick, asking Buildbucket for the build status
[22:43:05.120] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:05.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:138:0) after 1m0s
[22:44:05.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:138:0)
[22:44:05.398] Timer tick, asking Buildbucket for the build status
[22:44:05.511] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:05.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:139:0) after 1m0s
[22:45:05.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:139:0)
[22:45:05.594] Timer tick, asking Buildbucket for the build status
[22:45:05.669] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:05.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:140:0) after 1m0s
[22:46:05.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:140:0)
[22:46:05.689] Timer tick, asking Buildbucket for the build status
[22:46:05.845] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:05.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:141:0) after 1m0s
[22:47:06.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:141:0)
[22:47:06.007] Timer tick, asking Buildbucket for the build status
[22:47:06.125] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:06.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:142:0) after 1m0s
[22:48:06.330] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:142:0)
[22:48:06.330] Timer tick, asking Buildbucket for the build status
[22:48:06.404] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:06.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:143:0) after 1m0s
[22:49:06.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:143:0)
[22:49:06.735] Timer tick, asking Buildbucket for the build status
[22:49:06.845] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:06.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:144:0) after 1m0s
[22:50:07.310] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:144:0)
[22:50:07.310] Timer tick, asking Buildbucket for the build status
[22:50:07.483] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:07.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:145:0) after 1m0s
[22:51:07.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:145:0)
[22:51:07.503] Timer tick, asking Buildbucket for the build status
[22:51:07.619] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:07.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:146:0) after 1m0s
[22:52:07.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:146:0)
[22:52:07.779] Timer tick, asking Buildbucket for the build status
[22:52:07.843] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:07.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:147:0) after 1m0s
[22:53:08.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:147:0)
[22:53:08.542] Timer tick, asking Buildbucket for the build status
[22:53:08.607] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:08.607] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:148:0) after 1m0s
[22:54:09.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:148:0)
[22:54:09.228] Timer tick, asking Buildbucket for the build status
[22:54:09.304] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:149:0) after 1m0s
[22:55:09.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:149:0)
[22:55:09.761] Timer tick, asking Buildbucket for the build status
[22:55:11.137] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:11.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:150:0) after 1m0s
[22:56:11.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:150:0)
[22:56:11.624] Timer tick, asking Buildbucket for the build status
[22:56:11.664] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:11.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:151:0) after 1m0s
[22:57:12.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:151:0)
[22:57:12.294] Timer tick, asking Buildbucket for the build status
[22:57:12.398] Build 8932025575063954272: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:12.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9097455637138741232:152:0) after 1m0s
[22:57:42.959] Received PubSub notification, asking Buildbucket for the build status
[22:57:43.068] Build 8932025575063954272: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:57:43.068] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1540162661638503",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1540153637785534",
"id": "8932025575063954272",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"a93d048f9be00cdd061bdf6db4f512dd4beee34d\"}}",
"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/8932025575063954272/+/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\": [\"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\"]}}, \"properties\": {\"got_nacl_revision\": \"99673869a3cd8731d924bd32fa486feebfdc6c4f\", \"got_swarming_client_revision\": \"f78187ab77127de42555afe0ad410bebde6ac6a5\", \"got_revision\": \"a93d048f9be00cdd061bdf6db4f512dd4beee34d\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25280}\", \"$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@{#601457}\", \"branch\": \"refs/heads/master\", \"revision\": \"a93d048f9be00cdd061bdf6db4f512dd4beee34d\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"648d28ad62573c7b1a1e5b05a6122227f7272950\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"0cc11c684b5465b73ff107f7935ae72ca1dbbcff\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1540153637785534, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/a93d048f9be00cdd061bdf6db4f512dd4beee34d\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9097455637138741232\", \"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\": \"8932025575063954272\"}}, \"got_v8_revision\": \"d206a4b910f4138c15e04cf77544175ef7ffbe26\", \"got_v8_revision_cp\": \"refs/heads/7.2.45@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10465, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"b38acca7ccc48245ea6136b18f8542cbe92ad0a0\", \"notification_helper_unittests\": \"9415031ca6de2530e1347228926b5e7f03f1f424\", \"gpu_perftests\": \"a4cc26f5bef4c31b0abafae1a8332c213975e9ec\", \"vr_common_unittests\": \"5ad7385d43efbe58923fe0359321721cd0972696\", \"telemetry_unittests\": \"376736ec738fca032f8fe79ce186f28aa6ca6922\", \"load_library_perf_tests\": \"0938f2fd0d5232cc37895369de8e6dfa8f8d9ff0\", \"devtools_closure_compile\": \"e4e56ecf341b99135722ee7f746bdcee8d980454\", \"chromedriver_py_tests\": \"ab1be8d2a7f775752f35251a49ccb51f63d63506\", \"mojo_core_unittests\": \"e1338db2d7a6dddc20b2de4c3d51946bd1785087\", \"install_static_unittests\": \"a8f447c4e1b2220199843316ef0bfd10265d2b7f\", \"leveldb_service_unittests\": \"653d470a373731319d23346df64a70686668529c\", \"mini_installer_tests\": \"6d4da4f866463aba127cb5aa7c7cb6042ac7f8ae\", \"gcp_unittests\": \"3d413bd50670dfb03165ea6aa74f20bde6bdc935\", \"sbox_integration_tests\": \"4352b081cb9e26e25356d5a46da4229f28871ed0\", \"angle_unittests\": \"b080f2558bd8a5c114e767dadf2133cb443fd786\", \"cast_unittests\": \"7e262893f3ddd0934aa7295b714854ec641f171c\", \"cc_unittests\": \"2ae743070fc9e7e515b0b8adae0c586a20b966ca\", \"blink_common_unittests\": \"8ecb6abf645ac8c411727e1d91a447b746c18d64\", \"crashpad_tests\": \"b48d405c33703a22d90f248a57e36914ac77bc67\", \"telemetry_perf_tests_without_chrome\": \"84ec30a4c4ec830811480531f03885d9ef032468\", \"metrics_python_tests\": \"a31000cdada7b322bbc3b59093b436676d85f5c1\", \"message_center_unittests\": \"97ac1376fcf6b9640f90ab3ffee2190323b9bde9\", \"ppapi_unittests\": \"89fd78faa917daabb52cf51f9309c41134cfccfa\", \"extensions_unittests\": \"3b28743b0a702df50b8751025d4b5be2d110cd01\", \"gl_unittests_ozone\": \"97e536611206dfcd45d564d95a16248876768032\", \"app_shell_unittests\": \"c71569ae3e6cdf6682c78adc3ca09ee4e9c98946\", \"chrome_app_unittests\": \"c6725c238997b3763fcf58102ca99c1e0469a7fb\", \"gl_unittests\": \"97e536611206dfcd45d564d95a16248876768032\", \"gcm_unit_tests\": \"c5f4de04b15e4dd7264675fe728c697e0d64575b\", \"views_unittests\": \"4840a96b358075f47b6dee9cfba691043549dec7\", \"content_shell_crash_test\": \"f2bafa4894bd4d2c488266df74ddf8fba56c9297\", \"ui_base_unittests\": \"551c9143ae89432a3343c6f5f7c6636b09b4c476\", \"cronet_unittests\": \"d62e2eb413eb5a0c1365f06984e42e71cfcadb7c\", \"performance_test_suite\": \"1cf13591b508731846d89120ea2ddaa268550c68\", \"wm_unittests\": \"e47389160b0277f83d2338cc0c51b316dddc4460\", \"boringssl_crypto_tests\": \"73d10ab97012a349a02c03a00f8ff1207e6901e9\", \"gin_unittests\": \"503e20392a5e1201daf2d1fe75d75259ef4f66cc\", \"performance_browser_tests\": \"fedd89912877982bc64881423c013fbdd1ebff4b\", \"extensions_browsertests\": \"d42b5b62270be479846f77884f736353bb36086e\", \"webkit_python_tests\": \"e632d2a81c3d0499d9799372995efafc5a1bfa42\", \"headless_unittests\": \"a0b3e90a81c0b11291c75fc00f8d6f007a3034d2\", \"webkit_layout_tests\": \"52ea228abe487d01bb8f1875bf7baf3c279ccd2f\", \"vr_pixeltests\": \"6aa7000c2efba86f5c08b958a4a6b5eeeed4bdf6\", \"setup_unittests\": \"5e4af01804a99b35b480ae28a957370773f047ab\", \"webkit_unit_tests\": \"07ff5ebdc7ca7e7652d3a1153fc68ddd63cb0597\", \"content_unittests\": \"5b7529007c60e31733aea77abbf378c8977e3ef4\", \"performance_webview_test_suite\": \"3f052e452d810a82e8e2b57588770e5d2632386f\", \"wtf_unittests\": \"b62af613281b2756900017cac492a0c4e054d138\", \"webkit_layout_tests_exparchive\": \"e816b507634de219f78700215adcf4c63af2804c\", \"chrome_cleaner_unittests\": \"7d16cf029576cb710812b6cc1af4ae8274ef5bb0\", \"traffic_annotation_auditor_unittests\": \"1225c5fb3a06b95caacdfa9b75b98ced424338d1\", \"libjingle_xmpp_unittests\": \"227c8c9714e988d31e8d4f3660f6c43b5bb94e52\", \"remoting_unittests\": \"57d60cc7e5b13238216440e927d527846719fc36\", \"vr_common_perftests\": \"a528189cb19992d391a828f53396a21384673c4e\", \"filesystem_service_unittests\": \"929ab3e7c5930fb2a9c6c1ab7ec8e2f19fe89412\", \"chrome_elf_import_unittests\": \"65cb2f9189a23d501d67e1e0a4a125d3b74959ba\", \"installer_util_unittests\": \"15690dcdfe8f49f8ecadc9a1d0b10af4a9bd967e\", \"gfx_unittests\": \"3e630e8b682f1e2afabd2348e7261752875faa15\", \"headless_browsertests\": \"d5a9183390afc2609412a1ae342c5976dba85067\", \"capture_unittests\": \"44e7c0f9157676f292f96dd04ca3d820b76b713f\", \"chrome_elf_unittests\": \"faa5de2f8dafc896d35db4bbc339f6c3bdb39239\", \"telemetry_gpu_unittests\": \"ef9b0e4b4b5f7b7455156d75303994a15cdf1fce\", \"command_buffer_perftests\": \"30116caf57a320da23fa3d6ca6942c072da14431\", \"media_unittests\": \"8c77086671c3f05c218a3a0deeb38c765c3dba97\", \"chromedriver_unittests\": \"8effe9a5f7c01d7fc7ca0e4bbf0c8875a588a1b3\", \"views_mus_interactive_ui_tests\": \"fa71942ec8aa66777418c8b2cb59e2db53a7996b\", \"storage_unittests\": \"b5009201cd8fb31eff8afb465a8292bc9a0cc9e0\", \"media_service_unittests\": \"a9fed065277e5041ca8c8befabeff83fae81ed81\", \"compositor_unittests\": \"cdba5f9eedc15b73f6ab6aa7f98d95fac0510884\", \"latency_unittests\": \"85274365e4b4c4b80f42bebb79c89811cb9fd0db\", \"video_decode_accelerator_unittest\": \"3298c88140f8bb3d5182e8d675b95c4b27760d9b\", \"swiftshader_unittests\": \"de819118fae0a15aca56897b4f5e69a608ecba6d\", \"telemetry_perf_unittests\": \"5574652de7b8edadca95c805d306b491dad15cc1\", \"media_blink_unittests\": \"ef454d49795f2f6a7a97a432d6534aeaf6e1da7c\", \"views_mus_unittests\": \"31156f12322f60a8e88c1559571f0730e16ec3fa\", \"components_unittests\": \"115c1a9eabb47ede27734f8cb867659ef97bb3d2\", \"snapshot_unittests\": \"ffcb7cc08159dcc4c4d2a8a181a3140c576c01f6\", \"accessibility_unittests\": \"a9cd56b6426c896b08f26448e5e09fabd1e9d46c\", \"net_perftests\": \"9110571cb384e82e63bf9940e55eb5ce4978a642\", \"aura_unittests\": \"97f790506615a4d9fba7084f076e0d819dfde573\", \"services_unittests\": \"2c27382df821e1543f7d2c55341a34b2316a7ce9\", \"components_perftests\": \"b9fe959688213a9608c786b9516f616c0a326750\", \"events_unittests\": \"c9adc31a69b7eeba085c042651b04e3a78fe8aad\", \"tracing_perftests\": \"2d0fd59ea342b633cbe6647ae4dfd8f854bfc151\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"23365943995805138121cfec1210e15bd014deb0\", \"cacheinvalidation_unittests\": \"ed150e53d4a9e6248160c4901880f2269bb2689b\", \"viz_unittests\": \"d72c1c273b738bc335b5c3c424b1f40fe10076b3\", \"browser_tests\": \"88375caff227f7470281e0ea4695463ff6444159\", \"net_unittests\": \"b555d612cc410fba46982c93ab017408f32017c8\", \"pdf_unittests\": \"0fc64616ea9a36a57dcfe640ddeb0aaf8cde8e1f\", \"boringssl_ssl_tests\": \"d167046115bbf35e2c6e720df25b4ab52a1c8346\", \"sbox_validation_tests\": \"bf887b4972c8843bab290c1ee52c6d3f91dd0763\", \"elevation_service_unittests\": \"8a78e0a2aafc5f076b1fe049649a144fbb1c4ea7\", \"gpu_unittests\": \"d172f7189397640cfdba901bd9ff165bcd17ccb6\", \"native_theme_unittests\": \"04e1958fcfb2ab91e059b080b01a14c763c0b52e\", \"interactive_ui_tests\": \"cf93c83071350020d93438a56783bfb398d2dff0\", \"mojo_unittests\": \"3a95c5b6bfe8a89cac9a52520685877361e01ea7\", \"url_unittests\": \"2e7b935ac857f5de83b66c8aabeb3c85b27fa94a\", \"media_perftests\": \"d28e0489269a8d0a2153142e66e4bbd94d1d6135\", \"cronet_tests\": \"c9fd9deb06eb7db1cf7e8da1f3912f17fa55bb28\", \"google_apis_unittests\": \"6cf1d5eddd8ba47868215587d71a376f00e5a59d\", \"telemetry_gpu_integration_test\": \"10704ba3372171f4f5814c625d288d306eb2b101\", \"blink_heap_unittests\": \"7bdce490196ea292fdf74aea909f584163c0ad89\", \"midi_unittests\": \"8deaa8357fafafac3c1e1e4166f07d02cb491785\", \"base_unittests\": \"81955536f69af4fd96dfe0da01e492eecb806109\", \"sync_integration_tests\": \"19180769b9910cf9467c56bd40bdda06c659e4bf\", \"sql_unittests\": \"8db2c7f1e46cf4db46bd91499134b3b5a0d44f49\", \"courgette_unittests\": \"0f5f054b85fdc80a730d9cc29884399d05587b03\", \"blink_fuzzer_unittests\": \"f7489c16e763db1fe7ed0fc9bd13d5784eea4e83\", \"gl_tests\": \"20452a10884676980b64dc1dc400e5b5c5e6df01\", \"zucchini_unittests\": \"27d1ec0ac60b1c99a6dde13f307317ed295304c1\", \"ipc_tests\": \"fbd39f1074927ced6d206c3aedd787738057db8e\", \"angle_end2end_tests\": \"63b933348bc4719d28ba169039ea60725c4f8659\", \"blink_platform_unittests\": \"b46bd16315b189fff4e9ec06c5201987fffb1cc0\", \"components_browsertests\": \"3f3efc33f4522dafe1cdf2284e1905f6c5932562\", \"views_perftests\": \"f7c939301ed17acbc56d5486349c334e6745815b\", \"angle_perftests\": \"d51dd576a9966eeafe6652a3cb8555afe8b04318\", \"display_unittests\": \"79165e4065aeea5ef9f1147f43c206cb60783920\", \"sbox_unittests\": \"f2bc134fade0d41f05451385096058964eadba74\", \"service_manager_unittests\": \"96021d22683fa225ee559910839eaa89366300ec\", \"gles2_conform_test\": \"d7368f8b5655b17e250d3ac6601e9af3c1b62f1b\", \"jingle_unittests\": \"81573d5d6a90de2f89ca640415345109a50206cc\", \"skia_unittests\": \"9911a98cfa1420dc8242599d8dbd725bbc81a1f9\", \"angle_white_box_tests\": \"9546683f9d3fc8410145f2f2da545e3011240736\", \"crypto_unittests\": \"745b605ba1fd4fa2f75876147ecd7f2d92c67dfd\", \"nacl_loader_unittests\": \"a2ac55f664f562a27a725c8bb2b4fe7bad8432c0\", \"unit_tests\": \"9e2b61a7dcebc7b4352100778a9baa32d9f89460\", \"content_browsertests\": \"0e1f47c7ce7b74d3f98bdd12491718e65abef187\", \"printing_unittests\": \"c7966c73fd1a935d8a9bab8a2b2bcb5c6ff758bf\", \"device_unittests\": \"aed665ff8007c65ed9ba69bac29b6e2137b24a6f\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"13a00f110ef910a25763346d6538b60f12845656\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1540153741296166",
"status": "COMPLETED",
"status_changed_ts": "1540162662437027",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10465",
"builder:Windows deterministic",
"buildset:commit/git/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9097455637138741232",
"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/10465",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8932025575063954272",
"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/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a93d048f9be00cdd061bdf6db4f512dd4beee34d",
"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/8932025575063954272/+/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:9097455637138741232",
"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:5d21b61d8922783e1f86e64740632e2a34b9be92",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:40b1210840f54b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1540162662439588",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10465",
"utcnow_ts": "1540162663054880"
}
}
[22:57:43.069] Invocation finished in 2h30m26.645803017s with status SUCCEEDED