[20:12:04.241] New invocation is queued and will start shortly
[20:12:05.500] Starting the invocation (attempt 1)
[20:12:05.534] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:12:05.534] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:12:05.534] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9099721517809423968",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9099721517809423968",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"gitiles_ref:refs/heads/master"
]
}
[20:12:07.122] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537992725610774",
"id": "8934291455708650576",
"lease_expiration_ts": "1538136726905240",
"lease_key": "483345837",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1537992727043262",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10210",
"builder:Windows deterministic",
"buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099721517809423968",
"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/10210",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934291455708650576",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"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/8934291455708650576/+/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:9099721517809423968",
"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:3f7a0913a6a2ec20760cde9d3119057b0ed11693",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4030541fc3f3fd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1537992727043367",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10210",
"utcnow_ts": "1537992727112668"
}
}
[20:12:07.122] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10210
[20:12:07.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:2:0) after 1m0s
[20:12:09.823] Received PubSub notification, asking Buildbucket for the build status
[20:12:09.922] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:07.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:2:0)
[20:13:07.287] Timer tick, asking Buildbucket for the build status
[20:13:07.329] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:07.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:4:0) after 1m0s
[20:14:07.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:4:0)
[20:14:07.349] Timer tick, asking Buildbucket for the build status
[20:14:07.400] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:07.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:5:0) after 1m0s
[20:15:07.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:5:0)
[20:15:07.425] Timer tick, asking Buildbucket for the build status
[20:15:07.491] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:07.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:6:0) after 1m0s
[20:16:07.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:6:0)
[20:16:07.514] Timer tick, asking Buildbucket for the build status
[20:16:07.608] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:07.608] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:7:0) after 1m0s
[20:17:07.636] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:7:0)
[20:17:07.636] Timer tick, asking Buildbucket for the build status
[20:17:07.711] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:07.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:8:0) after 1m0s
[20:18:07.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:8:0)
[20:18:07.786] Timer tick, asking Buildbucket for the build status
[20:18:07.933] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:07.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:9:0) after 1m0s
[20:19:07.995] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:9:0)
[20:19:07.995] Timer tick, asking Buildbucket for the build status
[20:19:08.090] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:08.090] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:10:0) after 1m0s
[20:20:08.120] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:10:0)
[20:20:08.120] Timer tick, asking Buildbucket for the build status
[20:20:08.217] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:08.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:11:0) after 1m0s
[20:21:08.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:11:0)
[20:21:08.281] Timer tick, asking Buildbucket for the build status
[20:21:08.465] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:08.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:12:0) after 1m0s
[20:22:08.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:12:0)
[20:22:08.507] Timer tick, asking Buildbucket for the build status
[20:22:08.544] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:08.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:13:0) after 1m0s
[20:23:08.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:13:0)
[20:23:08.575] Timer tick, asking Buildbucket for the build status
[20:23:08.991] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:08.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:14:0) after 1m0s
[20:24:09.011] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:14:0)
[20:24:09.011] Timer tick, asking Buildbucket for the build status
[20:24:09.070] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:09.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:15:0) after 1m0s
[20:25:09.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:15:0)
[20:25:09.096] Timer tick, asking Buildbucket for the build status
[20:25:09.266] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:09.266] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:16:0) after 1m0s
[20:26:09.294] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:16:0)
[20:26:09.294] Timer tick, asking Buildbucket for the build status
[20:26:09.359] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:09.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:17:0) after 1m0s
[20:27:09.376] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:17:0)
[20:27:09.376] Timer tick, asking Buildbucket for the build status
[20:27:09.482] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:09.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:18:0) after 1m0s
[20:28:09.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:18:0)
[20:28:09.506] Timer tick, asking Buildbucket for the build status
[20:28:09.551] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:09.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:19:0) after 1m0s
[20:29:09.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:19:0)
[20:29:09.574] Timer tick, asking Buildbucket for the build status
[20:29:09.661] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:09.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:20:0) after 1m0s
[20:30:09.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:20:0)
[20:30:09.687] Timer tick, asking Buildbucket for the build status
[20:30:09.806] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:09.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:21:0) after 1m0s
[20:31:09.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:21:0)
[20:31:09.839] Timer tick, asking Buildbucket for the build status
[20:31:09.928] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:09.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:22:0) after 1m0s
[20:32:09.980] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:22:0)
[20:32:09.980] Timer tick, asking Buildbucket for the build status
[20:32:10.149] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:10.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:23:0) after 1m0s
[20:33:10.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:23:0)
[20:33:10.271] Timer tick, asking Buildbucket for the build status
[20:33:10.382] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:24:0) after 1m0s
[20:34:10.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:24:0)
[20:34:10.407] Timer tick, asking Buildbucket for the build status
[20:34:10.439] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:10.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:25:0) after 1m0s
[20:35:10.564] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:25:0)
[20:35:10.564] Timer tick, asking Buildbucket for the build status
[20:35:10.697] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:10.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:26:0) after 1m0s
[20:36:10.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:26:0)
[20:36:10.781] Timer tick, asking Buildbucket for the build status
[20:36:10.853] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:10.853] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:27:0) after 1m0s
[20:37:11.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:27:0)
[20:37:11.736] Timer tick, asking Buildbucket for the build status
[20:37:11.894] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:11.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:28:0) after 1m0s
[20:38:12.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:28:0)
[20:38:12.406] Timer tick, asking Buildbucket for the build status
[20:38:12.558] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:12.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:29:0) after 1m0s
[20:39:12.668] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:29:0)
[20:39:12.668] Timer tick, asking Buildbucket for the build status
[20:39:12.737] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:12.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:30:0) after 1m0s
[20:40:12.786] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:30:0)
[20:40:12.786] Timer tick, asking Buildbucket for the build status
[20:40:12.863] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:12.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:31:0) after 1m0s
[20:41:12.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:31:0)
[20:41:12.897] Timer tick, asking Buildbucket for the build status
[20:41:13.110] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:13.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:32:0) after 1m0s
[20:42:13.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:32:0)
[20:42:13.133] Timer tick, asking Buildbucket for the build status
[20:42:13.187] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:13.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:33:0) after 1m0s
[20:43:13.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:33:0)
[20:43:13.219] Timer tick, asking Buildbucket for the build status
[20:43:13.350] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:13.350] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:34:0) after 1m0s
[20:44:13.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:34:0)
[20:44:13.448] Timer tick, asking Buildbucket for the build status
[20:44:13.511] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:13.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:35:0) after 1m0s
[20:45:13.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:35:0)
[20:45:13.531] Timer tick, asking Buildbucket for the build status
[20:45:13.614] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:13.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:36:0) after 1m0s
[20:46:13.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:36:0)
[20:46:13.634] Timer tick, asking Buildbucket for the build status
[20:46:13.686] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:13.686] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:37:0) after 1m0s
[20:47:13.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:37:0)
[20:47:13.715] Timer tick, asking Buildbucket for the build status
[20:47:14.118] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:14.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:38:0) after 1m0s
[20:48:14.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:38:0)
[20:48:14.162] Timer tick, asking Buildbucket for the build status
[20:48:14.305] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:14.305] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:39:0) after 1m0s
[20:49:14.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:39:0)
[20:49:14.478] Timer tick, asking Buildbucket for the build status
[20:49:14.580] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:14.580] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:40:0) after 1m0s
[20:50:14.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:40:0)
[20:50:14.623] Timer tick, asking Buildbucket for the build status
[20:50:14.793] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:14.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:41:0) after 1m0s
[20:51:14.833] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:41:0)
[20:51:14.833] Timer tick, asking Buildbucket for the build status
[20:51:15.059] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:15.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:42:0) after 1m0s
[20:52:15.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:42:0)
[20:52:15.183] Timer tick, asking Buildbucket for the build status
[20:52:15.259] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:15.259] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:43:0) after 1m0s
[20:53:15.317] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:43:0)
[20:53:15.317] Timer tick, asking Buildbucket for the build status
[20:53:15.390] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:15.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:44:0) after 1m0s
[20:54:15.415] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:44:0)
[20:54:15.415] Timer tick, asking Buildbucket for the build status
[20:54:15.494] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:15.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:45:0) after 1m0s
[20:55:15.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:45:0)
[20:55:15.687] Timer tick, asking Buildbucket for the build status
[20:55:15.785] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:15.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:46:0) after 1m0s
[20:56:15.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:46:0)
[20:56:15.820] Timer tick, asking Buildbucket for the build status
[20:56:15.876] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:15.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:47:0) after 1m0s
[20:57:15.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:47:0)
[20:57:15.901] Timer tick, asking Buildbucket for the build status
[20:57:16.028] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:16.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:48:0) after 1m0s
[20:58:16.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:48:0)
[20:58:16.062] Timer tick, asking Buildbucket for the build status
[20:58:16.132] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:16.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:49:0) after 1m0s
[20:59:16.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:49:0)
[20:59:16.210] Timer tick, asking Buildbucket for the build status
[20:59:16.355] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:16.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:50:0) after 1m0s
[21:00:16.382] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:50:0)
[21:00:16.382] Timer tick, asking Buildbucket for the build status
[21:00:16.431] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:16.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:51:0) after 1m0s
[21:01:16.462] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:51:0)
[21:01:16.462] Timer tick, asking Buildbucket for the build status
[21:01:16.702] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:16.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:52:0) after 1m0s
[21:02:16.730] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:52:0)
[21:02:16.730] Timer tick, asking Buildbucket for the build status
[21:02:16.779] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:16.779] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:53:0) after 1m0s
[21:03:16.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:53:0)
[21:03:16.803] Timer tick, asking Buildbucket for the build status
[21:03:16.961] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:16.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:54:0) after 1m0s
[21:04:16.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:54:0)
[21:04:16.985] Timer tick, asking Buildbucket for the build status
[21:04:17.051] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:17.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:55:0) after 1m0s
[21:05:17.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:55:0)
[21:05:17.133] Timer tick, asking Buildbucket for the build status
[21:05:17.180] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:17.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:56:0) after 1m0s
[21:06:17.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:56:0)
[21:06:17.233] Timer tick, asking Buildbucket for the build status
[21:06:17.272] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:57:0) after 1m0s
[21:07:17.298] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:57:0)
[21:07:17.298] Timer tick, asking Buildbucket for the build status
[21:07:17.356] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:17.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:58:0) after 1m0s
[21:08:17.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:58:0)
[21:08:17.392] Timer tick, asking Buildbucket for the build status
[21:08:17.432] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:17.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:59:0) after 1m0s
[21:09:17.473] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:59:0)
[21:09:17.473] Timer tick, asking Buildbucket for the build status
[21:09:17.645] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:17.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:60:0) after 1m0s
[21:10:17.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:60:0)
[21:10:17.681] Timer tick, asking Buildbucket for the build status
[21:10:17.725] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:17.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:61:0) after 1m0s
[21:11:17.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:61:0)
[21:11:17.761] Timer tick, asking Buildbucket for the build status
[21:11:17.821] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:17.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:62:0) after 1m0s
[21:12:17.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:62:0)
[21:12:17.846] Timer tick, asking Buildbucket for the build status
[21:12:17.891] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:17.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:63:0) after 1m0s
[21:13:17.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:63:0)
[21:13:17.920] Timer tick, asking Buildbucket for the build status
[21:13:17.999] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:17.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:64:0) after 1m0s
[21:14:18.034] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:64:0)
[21:14:18.034] Timer tick, asking Buildbucket for the build status
[21:14:18.173] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:18.173] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:65:0) after 1m0s
[21:15:18.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:65:0)
[21:15:18.207] Timer tick, asking Buildbucket for the build status
[21:15:18.429] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:18.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:66:0) after 1m0s
[21:16:18.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:66:0)
[21:16:18.486] Timer tick, asking Buildbucket for the build status
[21:16:18.541] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:18.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:67:0) after 1m0s
[21:17:18.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:67:0)
[21:17:18.574] Timer tick, asking Buildbucket for the build status
[21:17:18.664] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:18.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:68:0) after 1m0s
[21:18:18.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:68:0)
[21:18:18.707] Timer tick, asking Buildbucket for the build status
[21:18:18.744] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:18.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:69:0) after 1m0s
[21:19:18.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:69:0)
[21:19:18.787] Timer tick, asking Buildbucket for the build status
[21:19:18.847] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:18.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:70:0) after 1m0s
[21:20:18.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:70:0)
[21:20:18.867] Timer tick, asking Buildbucket for the build status
[21:20:18.905] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:18.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:71:0) after 1m0s
[21:21:18.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:71:0)
[21:21:18.977] Timer tick, asking Buildbucket for the build status
[21:21:19.124] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:19.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:72:0) after 1m0s
[21:22:19.155] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:72:0)
[21:22:19.155] Timer tick, asking Buildbucket for the build status
[21:22:19.225] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:19.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:73:0) after 1m0s
[21:23:19.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:73:0)
[21:23:19.249] Timer tick, asking Buildbucket for the build status
[21:23:19.312] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:19.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:74:0) after 1m0s
[21:24:19.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:74:0)
[21:24:19.344] Timer tick, asking Buildbucket for the build status
[21:24:19.431] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:19.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:75:0) after 1m0s
[21:25:19.458] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:75:0)
[21:25:19.458] Timer tick, asking Buildbucket for the build status
[21:25:19.503] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:19.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:76:0) after 1m0s
[21:26:19.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:76:0)
[21:26:19.535] Timer tick, asking Buildbucket for the build status
[21:26:19.572] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:19.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:77:0) after 1m0s
[21:27:19.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:77:0)
[21:27:19.623] Timer tick, asking Buildbucket for the build status
[21:27:19.684] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:19.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:78:0) after 1m0s
[21:28:19.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:78:0)
[21:28:19.724] Timer tick, asking Buildbucket for the build status
[21:28:19.800] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:19.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:79:0) after 1m0s
[21:29:19.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:79:0)
[21:29:19.880] Timer tick, asking Buildbucket for the build status
[21:29:19.952] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:19.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:80:0) after 1m0s
[21:30:20.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:80:0)
[21:30:20.008] Timer tick, asking Buildbucket for the build status
[21:30:20.073] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:20.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:81:0) after 1m0s
[21:31:20.171] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:81:0)
[21:31:20.171] Timer tick, asking Buildbucket for the build status
[21:31:20.214] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:20.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:82:0) after 1m0s
[21:32:20.240] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:82:0)
[21:32:20.240] Timer tick, asking Buildbucket for the build status
[21:32:20.309] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:20.309] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:83:0) after 1m0s
[21:33:20.335] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:83:0)
[21:33:20.335] Timer tick, asking Buildbucket for the build status
[21:33:20.555] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:20.555] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:84:0) after 1m0s
[21:34:20.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:84:0)
[21:34:20.688] Timer tick, asking Buildbucket for the build status
[21:34:20.805] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:20.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:85:0) after 1m0s
[21:35:20.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:85:0)
[21:35:20.942] Timer tick, asking Buildbucket for the build status
[21:35:20.990] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:20.990] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:86:0) after 1m0s
[21:36:21.065] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:86:0)
[21:36:21.065] Timer tick, asking Buildbucket for the build status
[21:36:21.114] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:21.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:87:0) after 1m0s
[21:37:21.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:87:0)
[21:37:21.174] Timer tick, asking Buildbucket for the build status
[21:37:21.215] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:21.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:88:0) after 1m0s
[21:38:21.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:88:0)
[21:38:21.246] Timer tick, asking Buildbucket for the build status
[21:38:21.316] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:21.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:89:0) after 1m0s
[21:39:21.422] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:89:0)
[21:39:21.422] Timer tick, asking Buildbucket for the build status
[21:39:21.551] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:21.551] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:90:0) after 1m0s
[21:40:21.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:90:0)
[21:40:21.672] Timer tick, asking Buildbucket for the build status
[21:40:21.761] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:21.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:91:0) after 1m0s
[21:41:21.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:91:0)
[21:41:21.783] Timer tick, asking Buildbucket for the build status
[21:41:21.868] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:21.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:92:0) after 1m0s
[21:42:21.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:92:0)
[21:42:21.899] Timer tick, asking Buildbucket for the build status
[21:42:21.966] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:21.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:93:0) after 1m0s
[21:43:22.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:93:0)
[21:43:22.005] Timer tick, asking Buildbucket for the build status
[21:43:22.125] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:22.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:94:0) after 1m0s
[21:44:22.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:94:0)
[21:44:22.222] Timer tick, asking Buildbucket for the build status
[21:44:22.442] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:22.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:95:0) after 1m0s
[21:45:22.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:95:0)
[21:45:22.540] Timer tick, asking Buildbucket for the build status
[21:45:22.626] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:22.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:96:0) after 1m0s
[21:46:22.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:96:0)
[21:46:22.654] Timer tick, asking Buildbucket for the build status
[21:46:22.706] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:22.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:97:0) after 1m0s
[21:47:22.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:97:0)
[21:47:22.797] Timer tick, asking Buildbucket for the build status
[21:47:22.871] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:22.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:98:0) after 1m0s
[21:48:22.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:98:0)
[21:48:22.917] Timer tick, asking Buildbucket for the build status
[21:48:22.984] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:22.984] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:99:0) after 1m0s
[21:49:23.019] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:99:0)
[21:49:23.019] Timer tick, asking Buildbucket for the build status
[21:49:23.096] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:23.096] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:100:0) after 1m0s
[21:50:23.169] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:100:0)
[21:50:23.169] Timer tick, asking Buildbucket for the build status
[21:50:23.278] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:23.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:101:0) after 1m0s
[21:51:23.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:101:0)
[21:51:23.312] Timer tick, asking Buildbucket for the build status
[21:51:23.370] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:23.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:102:0) after 1m0s
[21:52:23.404] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:102:0)
[21:52:23.404] Timer tick, asking Buildbucket for the build status
[21:52:23.486] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:23.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:103:0) after 1m0s
[21:53:23.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:103:0)
[21:53:23.657] Timer tick, asking Buildbucket for the build status
[21:53:23.780] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:23.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:104:0) after 1m0s
[21:54:23.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:104:0)
[21:54:23.876] Timer tick, asking Buildbucket for the build status
[21:54:23.949] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:23.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:105:0) after 1m0s
[21:55:24.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:105:0)
[21:55:24.052] Timer tick, asking Buildbucket for the build status
[21:55:24.149] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:24.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:106:0) after 1m0s
[21:56:24.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:106:0)
[21:56:24.196] Timer tick, asking Buildbucket for the build status
[21:56:24.411] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:24.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:107:0) after 1m0s
[21:57:24.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:107:0)
[21:57:24.464] Timer tick, asking Buildbucket for the build status
[21:57:24.611] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:24.611] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:108:0) after 1m0s
[21:58:24.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:108:0)
[21:58:24.646] Timer tick, asking Buildbucket for the build status
[21:58:24.718] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:24.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:109:0) after 1m0s
[21:59:24.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:109:0)
[21:59:24.749] Timer tick, asking Buildbucket for the build status
[21:59:24.818] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:24.818] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:110:0) after 1m0s
[22:00:24.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:110:0)
[22:00:24.861] Timer tick, asking Buildbucket for the build status
[22:00:25.172] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:25.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:111:0) after 1m0s
[22:01:25.199] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:111:0)
[22:01:25.199] Timer tick, asking Buildbucket for the build status
[22:01:25.304] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:25.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:112:0) after 1m0s
[22:02:25.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:112:0)
[22:02:25.374] Timer tick, asking Buildbucket for the build status
[22:02:25.426] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:25.426] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:113:0) after 1m0s
[22:03:25.457] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:113:0)
[22:03:25.457] Timer tick, asking Buildbucket for the build status
[22:03:25.650] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:25.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:114:0) after 1m0s
[22:04:25.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:114:0)
[22:04:25.685] Timer tick, asking Buildbucket for the build status
[22:04:25.820] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:25.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:115:0) after 1m0s
[22:05:25.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:115:0)
[22:05:25.852] Timer tick, asking Buildbucket for the build status
[22:05:25.886] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:25.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:116:0) after 1m0s
[22:06:25.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:116:0)
[22:06:25.910] Timer tick, asking Buildbucket for the build status
[22:06:25.976] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:25.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:117:0) after 1m0s
[22:07:26.072] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:117:0)
[22:07:26.072] Timer tick, asking Buildbucket for the build status
[22:07:26.153] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:26.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:118:0) after 1m0s
[22:08:26.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:118:0)
[22:08:26.288] Timer tick, asking Buildbucket for the build status
[22:08:26.938] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:26.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:119:0) after 1m0s
[22:09:26.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:119:0)
[22:09:26.970] Timer tick, asking Buildbucket for the build status
[22:09:27.078] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:27.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:120:0) after 1m0s
[22:10:27.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:120:0)
[22:10:27.105] Timer tick, asking Buildbucket for the build status
[22:10:27.194] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:27.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:121:0) after 1m0s
[22:11:27.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:121:0)
[22:11:27.224] Timer tick, asking Buildbucket for the build status
[22:11:27.411] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:122:0) after 1m0s
[22:12:27.468] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:122:0)
[22:12:27.468] Timer tick, asking Buildbucket for the build status
[22:12:27.531] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:27.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:123:0) after 1m0s
[22:13:27.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:123:0)
[22:13:27.566] Timer tick, asking Buildbucket for the build status
[22:13:27.645] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:27.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:124:0) after 1m0s
[22:14:27.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:124:0)
[22:14:27.672] Timer tick, asking Buildbucket for the build status
[22:14:27.743] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:27.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:125:0) after 1m0s
[22:15:27.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:125:0)
[22:15:27.771] Timer tick, asking Buildbucket for the build status
[22:15:27.803] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:27.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:126:0) after 1m0s
[22:16:27.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:126:0)
[22:16:27.824] Timer tick, asking Buildbucket for the build status
[22:16:27.921] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:27.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:127:0) after 1m0s
[22:17:27.973] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:127:0)
[22:17:27.973] Timer tick, asking Buildbucket for the build status
[22:17:28.059] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:28.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:128:0) after 1m0s
[22:18:28.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:128:0)
[22:18:28.126] Timer tick, asking Buildbucket for the build status
[22:18:28.172] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:28.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:129:0) after 1m0s
[22:19:28.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:129:0)
[22:19:28.207] Timer tick, asking Buildbucket for the build status
[22:19:28.272] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:28.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:130:0) after 1m0s
[22:20:28.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:130:0)
[22:20:28.308] Timer tick, asking Buildbucket for the build status
[22:20:28.348] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:28.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:131:0) after 1m0s
[22:21:28.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:131:0)
[22:21:28.385] Timer tick, asking Buildbucket for the build status
[22:21:28.447] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:28.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:132:0) after 1m0s
[22:22:28.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:132:0)
[22:22:28.471] Timer tick, asking Buildbucket for the build status
[22:22:28.572] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:28.572] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:133:0) after 1m0s
[22:23:28.631] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:133:0)
[22:23:28.631] Timer tick, asking Buildbucket for the build status
[22:23:28.689] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:28.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:134:0) after 1m0s
[22:24:28.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:134:0)
[22:24:28.718] Timer tick, asking Buildbucket for the build status
[22:24:28.799] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:28.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:135:0) after 1m0s
[22:25:28.830] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:135:0)
[22:25:28.830] Timer tick, asking Buildbucket for the build status
[22:25:28.934] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:28.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:136:0) after 1m0s
[22:26:28.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:136:0)
[22:26:28.985] Timer tick, asking Buildbucket for the build status
[22:26:29.044] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:29.044] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:137:0) after 1m0s
[22:27:29.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:137:0)
[22:27:29.076] Timer tick, asking Buildbucket for the build status
[22:27:29.150] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:29.150] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:138:0) after 1m0s
[22:28:29.267] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:138:0)
[22:28:29.267] Timer tick, asking Buildbucket for the build status
[22:28:29.360] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:29.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:139:0) after 1m0s
[22:29:29.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:139:0)
[22:29:29.406] Timer tick, asking Buildbucket for the build status
[22:29:29.460] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:29.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:140:0) after 1m0s
[22:30:29.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:140:0)
[22:30:29.484] Timer tick, asking Buildbucket for the build status
[22:30:29.604] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:29.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:141:0) after 1m0s
[22:31:29.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:141:0)
[22:31:29.632] Timer tick, asking Buildbucket for the build status
[22:31:29.667] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:29.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:142:0) after 1m0s
[22:32:29.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:142:0)
[22:32:29.699] Timer tick, asking Buildbucket for the build status
[22:32:30.002] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:30.002] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:143:0) after 1m0s
[22:33:30.035] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:143:0)
[22:33:30.035] Timer tick, asking Buildbucket for the build status
[22:33:30.132] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:30.132] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:144:0) after 1m0s
[22:34:30.351] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:144:0)
[22:34:30.351] Timer tick, asking Buildbucket for the build status
[22:34:30.450] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:30.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:145:0) after 1m0s
[22:35:30.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:145:0)
[22:35:30.487] Timer tick, asking Buildbucket for the build status
[22:35:30.630] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:30.630] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:146:0) after 1m0s
[22:36:30.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:146:0)
[22:36:30.660] Timer tick, asking Buildbucket for the build status
[22:36:30.726] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:30.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:147:0) after 1m0s
[22:37:30.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:147:0)
[22:37:30.753] Timer tick, asking Buildbucket for the build status
[22:37:30.823] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:30.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:148:0) after 1m0s
[22:38:30.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:148:0)
[22:38:30.864] Timer tick, asking Buildbucket for the build status
[22:38:31.036] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:31.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:149:0) after 1m0s
[22:39:31.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:149:0)
[22:39:31.067] Timer tick, asking Buildbucket for the build status
[22:39:31.120] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:31.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:150:0) after 1m0s
[22:40:31.143] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:150:0)
[22:40:31.143] Timer tick, asking Buildbucket for the build status
[22:40:31.187] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:31.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:151:0) after 1m0s
[22:41:31.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:151:0)
[22:41:31.214] Timer tick, asking Buildbucket for the build status
[22:41:31.297] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:31.297] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:152:0) after 1m0s
[22:42:31.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:152:0)
[22:42:31.506] Timer tick, asking Buildbucket for the build status
[22:42:31.591] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:31.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:153:0) after 1m0s
[22:43:31.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:153:0)
[22:43:31.630] Timer tick, asking Buildbucket for the build status
[22:43:31.745] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:31.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:154:0) after 1m0s
[22:44:31.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:154:0)
[22:44:31.852] Timer tick, asking Buildbucket for the build status
[22:44:32.072] Build 8934291455708650576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:32.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9099721517809423968:155:0) after 1m0s
[22:45:20.608] Received PubSub notification, asking Buildbucket for the build status
[22:45:20.690] Build 8934291455708650576: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:45:20.690] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1538001919336558",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1537992725610774",
"id": "8934291455708650576",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\"}}",
"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/8934291455708650576/+/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\": [\"3793-c7dcd56\"], \"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\": \"2ebbdab4bfb1ed9dfe52ce756b34829207dbe25f\", \"got_swarming_client_revision\": \"486c9b53c4d54dd4b95bb6ce0e31160e600dfc11\", \"got_revision\": \"6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#24847}\", \"$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@{#594449}\", \"branch\": \"refs/heads/master\", \"revision\": \"6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"1c718f91de164290a2504ab6e9ba7a36aec0882e\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"af8b73c9e6320524ac7bc0aa43dc8d1b47257bc1\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1537992725610774, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9099721517809423968\", \"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\": \"8934291455708650576\"}}, \"got_v8_revision\": \"2012676a17faccdb4468dc490a52b5293a08af80\", \"got_v8_revision_cp\": \"refs/heads/7.1.183@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10210, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"a3140666d9a81779d320d47f5a4a067ac08be60f\", \"notification_helper_unittests\": \"97c40665b2d178d134b1eb56ce6e4525d15d6683\", \"gpu_perftests\": \"b422173e57933b8fa3103888b1b0fbb44fb7af89\", \"vr_common_unittests\": \"481cccb20d710a1722624f2da55b0363fb272dc8\", \"telemetry_unittests\": \"23e09934ad73853233869e4e68f1f0bd3455300d\", \"load_library_perf_tests\": \"ab60cfcd2fafd833623b95a961ddba4b44cc30dd\", \"devtools_closure_compile\": \"d73f056ff1387aebdb95028e4cc8b312ab030a08\", \"chromedriver_py_tests\": \"14372e140a34bc3fc596afec132de2931481080e\", \"mojo_core_unittests\": \"c3839306df7feb6c4901d318eff096a8d1ec91ee\", \"install_static_unittests\": \"0e8c2b59d6730b08169b592253e34204477ccef2\", \"leveldb_service_unittests\": \"6a15e1701b1fa546f1ecaed52c49e27c7b488cea\", \"mini_installer_tests\": \"5ff6836ba5fb3e4a5080aa825f023b8f69f20921\", \"jingle_unittests\": \"039d8da4034921648940390331da52b11454d7fa\", \"sbox_integration_tests\": \"c934e66319296429cb6f4ada43e4ea1c1d524b89\", \"angle_unittests\": \"c7cfdf7dea02a73ae2b9cf6ec810f1237612e020\", \"cast_unittests\": \"a16c26bb5654b90360a2b81f718c1aeca865d53e\", \"cc_unittests\": \"d51f8d33fafac455c01f73e732ae88acc1c3cc59\", \"blink_common_unittests\": \"7f602b1b5be3ce8f68c393727445b6d873836163\", \"crashpad_tests\": \"b781f728ca51f43fb22c6cc548105c34efd4e0fe\", \"telemetry_perf_tests_without_chrome\": \"11b23d4a37a695b0dbd039a3389ac7c0c9ad16da\", \"metrics_python_tests\": \"f95b0e49247ef3a6ca3e61b77ec9e90ea94bdf49\", \"message_center_unittests\": \"51e6c030167942a298e8cbe8354b690c0eb3a20d\", \"ppapi_unittests\": \"c1201e2e37afce1d1c5e9fad4d056c828cd0c832\", \"extensions_unittests\": \"6f0ee0dbe964eab81a482c29505e64cecf6b70bb\", \"gl_unittests_ozone\": \"f0cb30a06fd76695c65a53d9df44dfdef8efc94e\", \"app_shell_unittests\": \"b0077ee9f7ed7c949c1a0bf4ac12e665c777962c\", \"chrome_app_unittests\": \"f987c3b475574182a447277b9fa169b431749980\", \"gl_unittests\": \"f0cb30a06fd76695c65a53d9df44dfdef8efc94e\", \"gcm_unit_tests\": \"d8655bc505e68bc266804c5da908758d1848542b\", \"views_unittests\": \"5283d57bfee32b30c5d5b31ae3b2eff7892e7faf\", \"content_shell_crash_test\": \"84a75ec8e280ca7c0deaaeef1980f5e686955e87\", \"ui_base_unittests\": \"d84b17ce51ef96e8dd5cfd6baba179696589835d\", \"gles2_conform_test\": \"2f7c1f5b7fc2b0e902b13d93e02bbcd953561a8c\", \"cronet_unittests\": \"75cd31611dcfcfeb1b7380799ad6110803470721\", \"performance_test_suite\": \"36f24da1c71ae85529b42206fd43cef6c3bcdc26\", \"wm_unittests\": \"34fe7f473aae3afb8b3884fe0c0f2297ea16f2b7\", \"boringssl_crypto_tests\": \"3690eb70eeaf9cac4bfb38afb6ea4f071a294933\", \"gin_unittests\": \"6cb1caca8e0f22ee3d97949d8a355f32cad2352b\", \"performance_browser_tests\": \"0002fbfe3313cceb4b1c3a31ae865e469bcfe7fe\", \"extensions_browsertests\": \"fc2fa5673a50939f4c04c540a7e4250aae602507\", \"webkit_python_tests\": \"addb494b805a4c20d795b37dfb783e7018485278\", \"headless_unittests\": \"41c0518783c5d242f278c3f5b908b7b1b541a2bc\", \"webkit_layout_tests\": \"97fc39ffbfb976b20788bde9e73e91cf8095f799\", \"vr_pixeltests\": \"3260a793c9b94fb8f7db94533941176bcd1256e6\", \"setup_unittests\": \"32fe7b4a0d599be3230086c98f2a41db93170d21\", \"webkit_unit_tests\": \"da47825ec193fc0777eaa6b6512bcaf4ba604c4b\", \"content_unittests\": \"e29508ccfa7f6bd25a161cece29c25513883f68f\", \"performance_webview_test_suite\": \"2d7bf53b5922b3514d3cd56eda19abbc9ee1dc03\", \"wtf_unittests\": \"f57a7abf3aab8b80a0c2350218b747bdf26d15cb\", \"webkit_layout_tests_exparchive\": \"c84825be5f0a1752b5c01d61b1825631556b3197\", \"chrome_cleaner_unittests\": \"0344b0e32a0126507e387b9e3cecf145a33b7f31\", \"traffic_annotation_auditor_unittests\": \"8a87969e25631369c52784fea02e9bc18c14d740\", \"libjingle_xmpp_unittests\": \"57bb905178f3a9cac3add12f19a8378c117663a5\", \"remoting_unittests\": \"7c255ea3e2ce95d1da83a3b65e2000b29bdd45db\", \"vr_common_perftests\": \"9126be621445e1754e083b8cfd324e94646ebcd7\", \"filesystem_service_unittests\": \"bb208875621e5cd4e9603e8f1ae481b4a8c8a0f7\", \"chrome_elf_import_unittests\": \"aefd71c05ee9868cb72776f59d07c8b4a7672cb9\", \"installer_util_unittests\": \"7f4a63d0c806480e05fea55cd36a257c44885287\", \"gfx_unittests\": \"7175844ab82b2d7cb180003c07e7ac374850d5ae\", \"headless_browsertests\": \"f042045a1dd4840b5c9b33756a780d6aa7221d95\", \"capture_unittests\": \"44519bf8e08db12d2fbd37629b54f3c650aa9a30\", \"chrome_elf_unittests\": \"f1878c64e5194591946cd81efac011b37f580b0a\", \"telemetry_gpu_unittests\": \"5328142bccb4d3dc19943a0eef60cb33a17ead29\", \"command_buffer_perftests\": \"d7d1f0d0ebeff048becd961c444cd686322b816b\", \"media_unittests\": \"7fd2d5bcdaa7e00ab759159c55857b981bd4501e\", \"chromedriver_unittests\": \"926bb73c5338820439e22255f95985fe4024a89e\", \"views_mus_interactive_ui_tests\": \"5dc61b5c76b1b48fa89e540e501bcc431835a316\", \"storage_unittests\": \"5c4a1afcf6a20a6f8b37cbff957eb2ab8c18b324\", \"media_service_unittests\": \"8c8597895f693f16ace8bab4433f7d3340ff1f4a\", \"compositor_unittests\": \"11016e2256dca8d93a94b3c568247065efdf02c1\", \"latency_unittests\": \"0e62c144c814383b7a51bb316e7c5b79dab6db59\", \"video_decode_accelerator_unittest\": \"abede97b798fb9bc546a62d33c1c1ac95a180219\", \"swiftshader_unittests\": \"c32659635add06ad8c9fefaef21eb3df4cba3a0f\", \"telemetry_perf_unittests\": \"3b5134dd62a88e78f79768163ba92aedd6d08069\", \"media_blink_unittests\": \"f36970b77c0a8a8ff50b1e987bc17d3a3185433c\", \"views_mus_unittests\": \"a3e494f1b6071e0b586a7be571ba3b29eb1396b5\", \"components_unittests\": \"701974eeca7891572089d2bcf062e44a5872ef2e\", \"snapshot_unittests\": \"48d34ac0468f75f51999b2f6011de26eb1ff90eb\", \"accessibility_unittests\": \"eef3984b8191bdfa9549c664620d6878852998bb\", \"net_perftests\": \"2cecd0817ff50eb641f0ab0d296b94d51e789811\", \"aura_unittests\": \"81db77ae8d7082429c66c91c212a8b4dd52f1600\", \"services_unittests\": \"233649e9f4575bf742c4add75cc739f96a78a1a9\", \"components_perftests\": \"ee8ec0d874e00283c92329a8d3727ee963efce43\", \"events_unittests\": \"959d4e2d3460d78f15a62db41a3cefbfbc49e3de\", \"tracing_perftests\": \"25d804176a2eb72155f1a1f364c2ff887a75f76e\", \"chromedriver_replay_unittests\": \"50c6aef6c493544165526b2b516579428eb4b618\", \"ui_touch_selection_unittests\": \"b933ee9f962aefc3d50cfd173839d15138485a60\", \"cacheinvalidation_unittests\": \"5dc90716e347de894301c49ed3c8c2672ea3226e\", \"viz_unittests\": \"f0def7f1fc966e53ff7cf660026556040b75efc8\", \"browser_tests\": \"b817cce829dcd640ccb46123fe905f15d2885960\", \"net_unittests\": \"c2fa4df607e6b434db80f910c3fcc25d612c135c\", \"midi_unittests\": \"fccf0a525979c17e73c58aab512f8a331d149adf\", \"boringssl_ssl_tests\": \"e34426c18943cdfb0faedf8f19885b88167f383a\", \"sbox_validation_tests\": \"da646e2eed4505737a03c493c38a29201b30ab12\", \"elevation_service_unittests\": \"2a665a956b91c900bfae4637bdefe06e93392cf4\", \"gpu_unittests\": \"e0c1129fceafcf37b5b6c0a7b686fa5f16738bc7\", \"native_theme_unittests\": \"7041d38a132f332d18247b0aa515bccdffe7e0af\", \"interactive_ui_tests\": \"6e8fe5e93db258f07469ea6bb7ed76d06534ce6d\", \"mojo_unittests\": \"9e4aafb1f53314cf69c180fb5942ddefc0c36002\", \"url_unittests\": \"e1002d02d08f7508470127f7bf1918e2ac4541af\", \"media_perftests\": \"1c6a9e87d5233bff9228932baaf69364d5e9cf59\", \"cronet_tests\": \"90ccbecee393556d6abecb0ac324d954f7abec98\", \"google_apis_unittests\": \"8e9241a8dede6d133f223a2976fd6d671be4c7f4\", \"telemetry_gpu_integration_test\": \"5075cad1f9c5baea72c4a04bbffb842ae62b6d75\", \"blink_heap_unittests\": \"52803641acc81b003f900df318123b5a3d2307bd\", \"base_unittests\": \"4a8d82ca73da9d63ae2b081ca2a91a8e56e3c7c0\", \"sync_integration_tests\": \"8b6fdab66827ee61b5f4da1887e5fbd39c1d7aa9\", \"sql_unittests\": \"f245fd6f81659e70d86d78f509c93534229101dc\", \"courgette_unittests\": \"621a33c00ae00bb95be3ea82182feed0c2e15f48\", \"blink_fuzzer_unittests\": \"69aaa08a095ae2ce43a6f359126622c2e3668b87\", \"gl_tests\": \"2da8ad47aab5f8cdebfe7188e2b17fd0250ae6b2\", \"zucchini_unittests\": \"41bef46beb52bfd78685f104f098860ba2612ea8\", \"ipc_tests\": \"554ed025d9fba34c4134cdadad30619ce327b270\", \"angle_end2end_tests\": \"38a1c869f04b09e9afe66adee1f8b0f0f5cb208c\", \"blink_platform_unittests\": \"8f4d0f1bbb0750675a60f533ca2fb6f30326a08f\", \"components_browsertests\": \"cb8f2383b938865de3d59d71729e4158ebde1630\", \"views_perftests\": \"1df56cbf1203532f4b14195f2211a945b7f81d97\", \"angle_perftests\": \"ca5dd23f413d84299e89593088197cfeafe73cba\", \"display_unittests\": \"66aa63b33247c680ba7cd3138459de9c580837cb\", \"sbox_unittests\": \"d61c4f965a30664cbccfb5f500cc72324c8ceb8a\", \"service_manager_unittests\": \"0f14e61005409071877f7a062150ce0b2cbe4855\", \"pdf_unittests\": \"32c30bf62fc8e3921740d0c809fc6c28c4d5a9bd\", \"skia_unittests\": \"a51342692681e7ccaeebff25876248699f93f123\", \"angle_white_box_tests\": \"d0c70c64233baca7c46ebb629cb904171e6ecaed\", \"crypto_unittests\": \"69076deeb44121ddf8437f23ea3d643f88907999\", \"nacl_loader_unittests\": \"157db3d8ecaf69fc4e3313b868709a5a6287cfab\", \"unit_tests\": \"80da29b2cb438313bdd7d4069fee3ec0ff1f09ce\", \"content_browsertests\": \"4717caf950267dc53eaa2bd4ff65019d8f751f8b\", \"printing_unittests\": \"4caf15596fe547364493deadae225ae627999785\", \"device_unittests\": \"1ef06b5298e47668baee0cc3342f6ccb75a8120a\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1537992728557676",
"status": "COMPLETED",
"status_changed_ts": "1538001919932958",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10210",
"builder:Windows deterministic",
"buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9099721517809423968",
"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/10210",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8934291455708650576",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c790cbde9342069ed9b59b6709c8807b14f2913",
"swarming_tag:builder:Windows deterministic",
"swarming_tag:buildset:commit/git/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6fb30d318cd9a654e53e2d7d2d8f833d8cf98cf1",
"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/8934291455708650576/+/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:9099721517809423968",
"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:3f7a0913a6a2ec20760cde9d3119057b0ed11693",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4030541fc3f3fd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1538001919934338",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10210",
"utcnow_ts": "1538001920643381"
}
}
[22:45:20.690] Invocation finished in 2h33m16.466854962s with status SUCCEEDED