[21:41:30.690] New invocation is queued and will start shortly
[21:41:31.919] Starting the invocation (attempt 1)
[21:41:31.953] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:41:31.953] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:41:31.953] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9098900517980740992",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9098900517980740992",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"gitiles_ref:refs/heads/master"
]
}
[21:41:33.445] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538775692079330",
"id": "8933470455861186144",
"lease_expiration_ts": "1538919693214406",
"lease_key": "1617227217",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\"}}",
"project": "chromium",
"result_details_json": "null",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1538775693337871",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10308",
"builder:Windows deterministic",
"buildset:commit/git/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098900517980740992",
"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/10308",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933470455861186144",
"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/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"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/8933470455861186144/+/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:9098900517980740992",
"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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:405eff3e86a6f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1538775693337978",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10308",
"utcnow_ts": "1538775693432088"
}
}
[21:41:33.445] Task URL: https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10308
[21:41:33.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:2:0) after 1m0s
[21:41:35.789] Received PubSub notification, asking Buildbucket for the build status
[21:41:35.894] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:33.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:2:0)
[21:42:33.483] Timer tick, asking Buildbucket for the build status
[21:42:33.515] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:33.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:4:0) after 1m0s
[21:43:33.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:4:0)
[21:43:33.537] Timer tick, asking Buildbucket for the build status
[21:43:33.581] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:33.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:5:0) after 1m0s
[21:44:33.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:5:0)
[21:44:33.602] Timer tick, asking Buildbucket for the build status
[21:44:33.814] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:33.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:6:0) after 1m0s
[21:45:33.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:6:0)
[21:45:33.835] Timer tick, asking Buildbucket for the build status
[21:45:33.885] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:33.885] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:7:0) after 1m0s
[21:46:33.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:7:0)
[21:46:33.918] Timer tick, asking Buildbucket for the build status
[21:46:33.976] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:33.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:8:0) after 1m0s
[21:47:33.997] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:8:0)
[21:47:33.997] Timer tick, asking Buildbucket for the build status
[21:47:34.058] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:34.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:9:0) after 1m0s
[21:48:34.090] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:9:0)
[21:48:34.090] Timer tick, asking Buildbucket for the build status
[21:48:34.224] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:34.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:10:0) after 1m0s
[21:49:34.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:10:0)
[21:49:34.245] Timer tick, asking Buildbucket for the build status
[21:49:34.307] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:34.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:11:0) after 1m0s
[21:50:34.328] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:11:0)
[21:50:34.328] Timer tick, asking Buildbucket for the build status
[21:50:34.359] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:34.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:12:0) after 1m0s
[21:51:34.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:12:0)
[21:51:34.386] Timer tick, asking Buildbucket for the build status
[21:51:34.461] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:34.461] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:13:0) after 1m0s
[21:52:34.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:13:0)
[21:52:34.500] Timer tick, asking Buildbucket for the build status
[21:52:34.609] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:34.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:14:0) after 1m0s
[21:53:34.685] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:14:0)
[21:53:34.685] Timer tick, asking Buildbucket for the build status
[21:53:34.869] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:34.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:15:0) after 1m0s
[21:54:34.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:15:0)
[21:54:34.908] Timer tick, asking Buildbucket for the build status
[21:54:34.947] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:34.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:16:0) after 1m0s
[21:55:34.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:16:0)
[21:55:34.972] Timer tick, asking Buildbucket for the build status
[21:55:35.009] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:35.009] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:17:0) after 1m0s
[21:56:35.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:17:0)
[21:56:35.029] Timer tick, asking Buildbucket for the build status
[21:56:35.087] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:35.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:18:0) after 1m0s
[21:57:35.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:18:0)
[21:57:35.109] Timer tick, asking Buildbucket for the build status
[21:57:35.168] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:35.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:19:0) after 1m0s
[21:58:35.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:19:0)
[21:58:35.190] Timer tick, asking Buildbucket for the build status
[21:58:35.253] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:35.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:20:0) after 1m0s
[21:59:35.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:20:0)
[21:59:35.281] Timer tick, asking Buildbucket for the build status
[21:59:35.321] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:35.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:21:0) after 1m0s
[22:00:35.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:21:0)
[22:00:35.343] Timer tick, asking Buildbucket for the build status
[22:00:35.451] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:22:0) after 1m0s
[22:01:35.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:22:0)
[22:01:35.503] Timer tick, asking Buildbucket for the build status
[22:01:35.558] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:35.558] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:23:0) after 1m0s
[22:02:35.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:23:0)
[22:02:35.583] Timer tick, asking Buildbucket for the build status
[22:02:35.647] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:35.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:24:0) after 1m0s
[22:03:35.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:24:0)
[22:03:35.672] Timer tick, asking Buildbucket for the build status
[22:03:35.709] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:35.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:25:0) after 1m0s
[22:04:35.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:25:0)
[22:04:35.754] Timer tick, asking Buildbucket for the build status
[22:04:35.802] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:35.802] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:26:0) after 1m0s
[22:05:35.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:26:0)
[22:05:35.827] Timer tick, asking Buildbucket for the build status
[22:05:35.944] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:35.944] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:27:0) after 1m0s
[22:06:35.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:27:0)
[22:06:35.994] Timer tick, asking Buildbucket for the build status
[22:06:36.052] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:36.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:28:0) after 1m0s
[22:07:36.086] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:28:0)
[22:07:36.086] Timer tick, asking Buildbucket for the build status
[22:07:36.179] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:36.179] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:29:0) after 1m0s
[22:08:36.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:29:0)
[22:08:36.303] Timer tick, asking Buildbucket for the build status
[22:08:36.509] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:36.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:30:0) after 1m0s
[22:09:36.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:30:0)
[22:09:36.611] Timer tick, asking Buildbucket for the build status
[22:09:36.645] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:36.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:31:0) after 1m0s
[22:10:36.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:31:0)
[22:10:36.672] Timer tick, asking Buildbucket for the build status
[22:10:36.761] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:36.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:32:0) after 1m0s
[22:11:36.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:32:0)
[22:11:36.828] Timer tick, asking Buildbucket for the build status
[22:11:36.924] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:36.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:33:0) after 1m0s
[22:12:36.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:33:0)
[22:12:36.950] Timer tick, asking Buildbucket for the build status
[22:12:36.988] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:36.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:34:0) after 1m0s
[22:13:37.023] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:34:0)
[22:13:37.023] Timer tick, asking Buildbucket for the build status
[22:13:37.206] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:37.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:35:0) after 1m0s
[22:14:37.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:35:0)
[22:14:37.231] Timer tick, asking Buildbucket for the build status
[22:14:37.285] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:37.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:36:0) after 1m0s
[22:15:37.319] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:36:0)
[22:15:37.319] Timer tick, asking Buildbucket for the build status
[22:15:37.411] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:37.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:37:0) after 1m0s
[22:16:37.441] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:37:0)
[22:16:37.441] Timer tick, asking Buildbucket for the build status
[22:16:37.499] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:37.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:38:0) after 1m0s
[22:17:37.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:38:0)
[22:17:37.529] Timer tick, asking Buildbucket for the build status
[22:17:37.601] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:37.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:39:0) after 1m0s
[22:18:37.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:39:0)
[22:18:37.630] Timer tick, asking Buildbucket for the build status
[22:18:37.701] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:37.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:40:0) after 1m0s
[22:19:37.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:40:0)
[22:19:37.724] Timer tick, asking Buildbucket for the build status
[22:19:37.774] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:37.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:41:0) after 1m0s
[22:20:37.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:41:0)
[22:20:37.800] Timer tick, asking Buildbucket for the build status
[22:20:37.941] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:37.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:42:0) after 1m0s
[22:21:38.142] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:42:0)
[22:21:38.142] Timer tick, asking Buildbucket for the build status
[22:21:38.180] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:38.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:43:0) after 1m0s
[22:22:38.206] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:43:0)
[22:22:38.206] Timer tick, asking Buildbucket for the build status
[22:22:38.381] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:38.381] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:44:0) after 1m0s
[22:23:38.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:44:0)
[22:23:38.402] Timer tick, asking Buildbucket for the build status
[22:23:38.439] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:38.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:45:0) after 1m0s
[22:24:38.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:45:0)
[22:24:38.459] Timer tick, asking Buildbucket for the build status
[22:24:38.588] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:38.588] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:46:0) after 1m0s
[22:25:38.627] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:46:0)
[22:25:38.627] Timer tick, asking Buildbucket for the build status
[22:25:38.706] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:38.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:47:0) after 1m0s
[22:26:38.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:47:0)
[22:26:38.755] Timer tick, asking Buildbucket for the build status
[22:26:38.794] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:38.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:48:0) after 1m0s
[22:27:38.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:48:0)
[22:27:38.817] Timer tick, asking Buildbucket for the build status
[22:27:38.878] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:38.878] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:49:0) after 1m0s
[22:28:38.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:49:0)
[22:28:38.908] Timer tick, asking Buildbucket for the build status
[22:28:38.950] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:38.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:50:0) after 1m0s
[22:29:38.994] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:50:0)
[22:29:38.994] Timer tick, asking Buildbucket for the build status
[22:29:39.030] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:39.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:51:0) after 1m0s
[22:30:39.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:51:0)
[22:30:39.057] Timer tick, asking Buildbucket for the build status
[22:30:39.214] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:39.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:52:0) after 1m0s
[22:31:39.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:52:0)
[22:31:39.245] Timer tick, asking Buildbucket for the build status
[22:31:39.354] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:39.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:53:0) after 1m0s
[22:32:39.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:53:0)
[22:32:39.400] Timer tick, asking Buildbucket for the build status
[22:32:39.435] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:39.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:54:0) after 1m0s
[22:33:39.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:54:0)
[22:33:39.463] Timer tick, asking Buildbucket for the build status
[22:33:39.503] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:39.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:55:0) after 1m0s
[22:34:39.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:55:0)
[22:34:39.537] Timer tick, asking Buildbucket for the build status
[22:34:39.667] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:39.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:56:0) after 1m0s
[22:35:39.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:56:0)
[22:35:39.699] Timer tick, asking Buildbucket for the build status
[22:35:39.742] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:39.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:57:0) after 1m0s
[22:36:39.778] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:57:0)
[22:36:39.778] Timer tick, asking Buildbucket for the build status
[22:36:39.817] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:39.817] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:58:0) after 1m0s
[22:37:39.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:58:0)
[22:37:39.844] Timer tick, asking Buildbucket for the build status
[22:37:39.884] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:39.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:59:0) after 1m0s
[22:38:39.967] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:59:0)
[22:38:39.967] Timer tick, asking Buildbucket for the build status
[22:38:40.046] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:40.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:60:0) after 1m0s
[22:39:40.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:60:0)
[22:39:40.074] Timer tick, asking Buildbucket for the build status
[22:39:40.142] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:40.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:61:0) after 1m0s
[22:40:40.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:61:0)
[22:40:40.200] Timer tick, asking Buildbucket for the build status
[22:40:40.303] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:40.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:62:0) after 1m0s
[22:41:40.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:62:0)
[22:41:40.333] Timer tick, asking Buildbucket for the build status
[22:41:40.392] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:40.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:63:0) after 1m0s
[22:42:40.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:63:0)
[22:42:40.416] Timer tick, asking Buildbucket for the build status
[22:42:40.476] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:40.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:64:0) after 1m0s
[22:43:40.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:64:0)
[22:43:40.525] Timer tick, asking Buildbucket for the build status
[22:43:40.636] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:40.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:65:0) after 1m0s
[22:44:40.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:65:0)
[22:44:40.672] Timer tick, asking Buildbucket for the build status
[22:44:40.740] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:40.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:66:0) after 1m0s
[22:45:40.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:66:0)
[22:45:40.801] Timer tick, asking Buildbucket for the build status
[22:45:40.884] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:40.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:67:0) after 1m0s
[22:46:40.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:67:0)
[22:46:40.934] Timer tick, asking Buildbucket for the build status
[22:46:40.976] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:40.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:68:0) after 1m0s
[22:47:40.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:68:0)
[22:47:40.998] Timer tick, asking Buildbucket for the build status
[22:47:41.040] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:41.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:69:0) after 1m0s
[22:48:41.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:69:0)
[22:48:41.071] Timer tick, asking Buildbucket for the build status
[22:48:41.130] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:41.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:70:0) after 1m0s
[22:49:41.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:70:0)
[22:49:41.152] Timer tick, asking Buildbucket for the build status
[22:49:41.222] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:41.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:71:0) after 1m0s
[22:50:41.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:71:0)
[22:50:41.257] Timer tick, asking Buildbucket for the build status
[22:50:41.319] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:41.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:72:0) after 1m0s
[22:51:41.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:72:0)
[22:51:41.386] Timer tick, asking Buildbucket for the build status
[22:51:41.456] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:41.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:73:0) after 1m0s
[22:52:41.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:73:0)
[22:52:41.502] Timer tick, asking Buildbucket for the build status
[22:52:41.664] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:41.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:74:0) after 1m0s
[22:53:41.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:74:0)
[22:53:41.693] Timer tick, asking Buildbucket for the build status
[22:53:41.894] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:41.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:75:0) after 1m0s
[22:54:41.930] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:75:0)
[22:54:41.930] Timer tick, asking Buildbucket for the build status
[22:54:42.084] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:42.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:76:0) after 1m0s
[22:55:42.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:76:0)
[22:55:42.132] Timer tick, asking Buildbucket for the build status
[22:55:42.214] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:42.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:77:0) after 1m0s
[22:56:42.275] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:77:0)
[22:56:42.275] Timer tick, asking Buildbucket for the build status
[22:56:42.322] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:42.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:78:0) after 1m0s
[22:57:42.346] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:78:0)
[22:57:42.346] Timer tick, asking Buildbucket for the build status
[22:57:42.563] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:42.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:79:0) after 1m0s
[22:58:42.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:79:0)
[22:58:42.603] Timer tick, asking Buildbucket for the build status
[22:58:42.641] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:42.641] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:80:0) after 1m0s
[22:59:42.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:80:0)
[22:59:42.767] Timer tick, asking Buildbucket for the build status
[22:59:42.866] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:42.866] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:81:0) after 1m0s
[23:00:42.908] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:81:0)
[23:00:42.908] Timer tick, asking Buildbucket for the build status
[23:00:42.983] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:42.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:82:0) after 1m0s
[23:01:43.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:82:0)
[23:01:43.031] Timer tick, asking Buildbucket for the build status
[23:01:43.108] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:43.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:83:0) after 1m0s
[23:02:43.140] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:83:0)
[23:02:43.140] Timer tick, asking Buildbucket for the build status
[23:02:43.210] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:43.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:84:0) after 1m0s
[23:03:43.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:84:0)
[23:03:43.296] Timer tick, asking Buildbucket for the build status
[23:03:43.445] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:43.445] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:85:0) after 1m0s
[23:04:43.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:85:0)
[23:04:43.470] Timer tick, asking Buildbucket for the build status
[23:04:43.548] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:43.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:86:0) after 1m0s
[23:05:43.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:86:0)
[23:05:43.597] Timer tick, asking Buildbucket for the build status
[23:05:43.635] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:43.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:87:0) after 1m0s
[23:06:43.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:87:0)
[23:06:43.672] Timer tick, asking Buildbucket for the build status
[23:06:43.718] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:43.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:88:0) after 1m0s
[23:07:43.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:88:0)
[23:07:43.755] Timer tick, asking Buildbucket for the build status
[23:07:43.868] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:43.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:89:0) after 1m0s
[23:08:43.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:89:0)
[23:08:43.935] Timer tick, asking Buildbucket for the build status
[23:08:43.966] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:43.966] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:90:0) after 1m0s
[23:09:44.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:90:0)
[23:09:44.045] Timer tick, asking Buildbucket for the build status
[23:09:44.114] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:44.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:91:0) after 1m0s
[23:10:44.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:91:0)
[23:10:44.152] Timer tick, asking Buildbucket for the build status
[23:10:44.229] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:44.229] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:92:0) after 1m0s
[23:11:44.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:92:0)
[23:11:44.303] Timer tick, asking Buildbucket for the build status
[23:11:44.499] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:44.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:93:0) after 1m0s
[23:12:44.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:93:0)
[23:12:44.542] Timer tick, asking Buildbucket for the build status
[23:12:44.586] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:44.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:94:0) after 1m0s
[23:13:44.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:94:0)
[23:13:44.609] Timer tick, asking Buildbucket for the build status
[23:13:44.645] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:44.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:95:0) after 1m0s
[23:14:44.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:95:0)
[23:14:44.681] Timer tick, asking Buildbucket for the build status
[23:14:59.568] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:59.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:96:0) after 1m0s
[23:15:59.607] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:96:0)
[23:15:59.607] Timer tick, asking Buildbucket for the build status
[23:15:59.673] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:59.673] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:97:0) after 1m0s
[23:16:59.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:97:0)
[23:16:59.719] Timer tick, asking Buildbucket for the build status
[23:17:00.000] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:00.000] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:98:0) after 1m0s
[23:18:00.031] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:98:0)
[23:18:00.031] Timer tick, asking Buildbucket for the build status
[23:18:00.105] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:00.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:99:0) after 1m0s
[23:19:00.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:99:0)
[23:19:00.187] Timer tick, asking Buildbucket for the build status
[23:19:00.476] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:00.476] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:100:0) after 1m0s
[23:20:00.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:100:0)
[23:20:00.566] Timer tick, asking Buildbucket for the build status
[23:20:00.636] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:00.636] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:101:0) after 1m0s
[23:21:00.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:101:0)
[23:21:00.702] Timer tick, asking Buildbucket for the build status
[23:21:00.847] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:00.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:102:0) after 1m0s
[23:22:00.890] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:102:0)
[23:22:00.890] Timer tick, asking Buildbucket for the build status
[23:22:01.066] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:01.066] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:103:0) after 1m0s
[23:23:01.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:103:0)
[23:23:01.114] Timer tick, asking Buildbucket for the build status
[23:23:01.189] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:01.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:104:0) after 1m0s
[23:24:01.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:104:0)
[23:24:01.233] Timer tick, asking Buildbucket for the build status
[23:24:01.302] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:01.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:105:0) after 1m0s
[23:25:01.403] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:105:0)
[23:25:01.403] Timer tick, asking Buildbucket for the build status
[23:25:01.597] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:01.597] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:106:0) after 1m0s
[23:26:01.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:106:0)
[23:26:01.632] Timer tick, asking Buildbucket for the build status
[23:26:01.725] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:01.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:107:0) after 1m0s
[23:27:01.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:107:0)
[23:27:01.766] Timer tick, asking Buildbucket for the build status
[23:27:01.917] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:01.917] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:108:0) after 1m0s
[23:28:01.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:108:0)
[23:28:01.943] Timer tick, asking Buildbucket for the build status
[23:28:02.004] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:02.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:109:0) after 1m0s
[23:29:02.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:109:0)
[23:29:02.027] Timer tick, asking Buildbucket for the build status
[23:29:02.171] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:02.171] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:110:0) after 1m0s
[23:30:02.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:110:0)
[23:30:02.213] Timer tick, asking Buildbucket for the build status
[23:30:02.769] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:02.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:111:0) after 1m0s
[23:31:02.815] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:111:0)
[23:31:02.815] Timer tick, asking Buildbucket for the build status
[23:31:02.880] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:02.880] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:112:0) after 1m0s
[23:32:03.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:112:0)
[23:32:03.007] Timer tick, asking Buildbucket for the build status
[23:32:03.058] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:03.058] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:113:0) after 1m0s
[23:33:03.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:113:0)
[23:33:03.087] Timer tick, asking Buildbucket for the build status
[23:33:03.165] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:03.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:114:0) after 1m0s
[23:34:03.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:114:0)
[23:34:03.195] Timer tick, asking Buildbucket for the build status
[23:34:03.345] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:03.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:115:0) after 1m0s
[23:35:03.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:115:0)
[23:35:03.393] Timer tick, asking Buildbucket for the build status
[23:35:03.488] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:03.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:116:0) after 1m0s
[23:36:03.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:116:0)
[23:36:03.513] Timer tick, asking Buildbucket for the build status
[23:36:03.601] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:03.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:117:0) after 1m0s
[23:37:03.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:117:0)
[23:37:03.628] Timer tick, asking Buildbucket for the build status
[23:37:03.742] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:03.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:118:0) after 1m0s
[23:38:03.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:118:0)
[23:38:03.810] Timer tick, asking Buildbucket for the build status
[23:38:03.937] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:03.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:119:0) after 1m0s
[23:39:03.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:119:0)
[23:39:03.988] Timer tick, asking Buildbucket for the build status
[23:39:04.072] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:04.072] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:120:0) after 1m0s
[23:40:04.121] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:120:0)
[23:40:04.121] Timer tick, asking Buildbucket for the build status
[23:40:04.193] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:04.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:121:0) after 1m0s
[23:41:04.323] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:121:0)
[23:41:04.323] Timer tick, asking Buildbucket for the build status
[23:41:04.420] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:122:0) after 1m0s
[23:42:04.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:122:0)
[23:42:04.479] Timer tick, asking Buildbucket for the build status
[23:42:04.578] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:04.579] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:123:0) after 1m0s
[23:43:04.630] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:123:0)
[23:43:04.630] Timer tick, asking Buildbucket for the build status
[23:43:04.691] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:04.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:124:0) after 1m0s
[23:44:04.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:124:0)
[23:44:04.717] Timer tick, asking Buildbucket for the build status
[23:44:04.793] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:125:0) after 1m0s
[23:45:04.821] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:125:0)
[23:45:04.821] Timer tick, asking Buildbucket for the build status
[23:45:04.875] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:04.875] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:126:0) after 1m0s
[23:46:04.905] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:126:0)
[23:46:04.905] Timer tick, asking Buildbucket for the build status
[23:46:04.942] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:04.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:127:0) after 1m0s
[23:47:05.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:127:0)
[23:47:05.103] Timer tick, asking Buildbucket for the build status
[23:47:05.154] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:05.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:128:0) after 1m0s
[23:48:05.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:128:0)
[23:48:05.185] Timer tick, asking Buildbucket for the build status
[23:48:05.671] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:129:0) after 1m0s
[23:49:05.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:129:0)
[23:49:05.694] Timer tick, asking Buildbucket for the build status
[23:49:05.828] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:05.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:130:0) after 1m0s
[23:50:05.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:130:0)
[23:50:05.881] Timer tick, asking Buildbucket for the build status
[23:50:05.968] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:05.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:131:0) after 1m0s
[23:51:06.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:131:0)
[23:51:06.012] Timer tick, asking Buildbucket for the build status
[23:51:06.057] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:06.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:132:0) after 1m0s
[23:52:06.114] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:132:0)
[23:52:06.114] Timer tick, asking Buildbucket for the build status
[23:52:06.181] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:06.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:133:0) after 1m0s
[23:53:06.255] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:133:0)
[23:53:06.255] Timer tick, asking Buildbucket for the build status
[23:53:06.465] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:06.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:134:0) after 1m0s
[23:54:06.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:134:0)
[23:54:06.497] Timer tick, asking Buildbucket for the build status
[23:54:06.561] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:06.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:135:0) after 1m0s
[23:55:06.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:135:0)
[23:55:06.584] Timer tick, asking Buildbucket for the build status
[23:55:06.654] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:06.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:136:0) after 1m0s
[23:56:06.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:136:0)
[23:56:06.689] Timer tick, asking Buildbucket for the build status
[23:56:06.814] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:06.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:137:0) after 1m0s
[23:57:06.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:137:0)
[23:57:06.928] Timer tick, asking Buildbucket for the build status
[23:57:07.039] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:07.040] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:138:0) after 1m0s
[23:58:07.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:138:0)
[23:58:07.071] Timer tick, asking Buildbucket for the build status
[23:58:07.149] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:07.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:139:0) after 1m0s
[23:59:07.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:139:0)
[23:59:07.179] Timer tick, asking Buildbucket for the build status
[23:59:07.252] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:07.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:140:0) after 1m0s
[00:00:07.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:140:0)
[00:00:07.293] Timer tick, asking Buildbucket for the build status
[00:00:07.329] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:07.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:141:0) after 1m0s
[00:01:07.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:141:0)
[00:01:07.362] Timer tick, asking Buildbucket for the build status
[00:01:07.425] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:07.425] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:142:0) after 1m0s
[00:02:07.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:142:0)
[00:02:07.488] Timer tick, asking Buildbucket for the build status
[00:02:07.562] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:07.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:143:0) after 1m0s
[00:03:07.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:143:0)
[00:03:07.601] Timer tick, asking Buildbucket for the build status
[00:03:07.679] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:07.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:144:0) after 1m0s
[00:04:07.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:144:0)
[00:04:07.725] Timer tick, asking Buildbucket for the build status
[00:04:07.809] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:07.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:145:0) after 1m0s
[00:05:07.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:145:0)
[00:05:07.840] Timer tick, asking Buildbucket for the build status
[00:05:08.008] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:08.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:146:0) after 1m0s
[00:06:08.053] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:146:0)
[00:06:08.053] Timer tick, asking Buildbucket for the build status
[00:06:08.140] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:08.140] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:147:0) after 1m0s
[00:07:08.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:147:0)
[00:07:08.195] Timer tick, asking Buildbucket for the build status
[00:07:08.410] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:08.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:148:0) after 1m0s
[00:08:08.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:148:0)
[00:08:08.447] Timer tick, asking Buildbucket for the build status
[00:08:08.562] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:08.562] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:149:0) after 1m0s
[00:09:08.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:149:0)
[00:09:08.598] Timer tick, asking Buildbucket for the build status
[00:09:08.661] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:08.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:150:0) after 1m0s
[00:10:08.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:150:0)
[00:10:08.692] Timer tick, asking Buildbucket for the build status
[00:10:08.845] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:08.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:151:0) after 1m0s
[00:11:08.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:151:0)
[00:11:08.885] Timer tick, asking Buildbucket for the build status
[00:11:09.016] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:09.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:152:0) after 1m0s
[00:12:09.057] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:152:0)
[00:12:09.057] Timer tick, asking Buildbucket for the build status
[00:12:09.116] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:09.116] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:153:0) after 1m0s
[00:13:09.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:153:0)
[00:13:09.153] Timer tick, asking Buildbucket for the build status
[00:13:09.251] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:09.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:154:0) after 1m0s
[00:14:09.283] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:154:0)
[00:14:09.283] Timer tick, asking Buildbucket for the build status
[00:14:09.467] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:09.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:155:0) after 1m0s
[00:15:09.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:155:0)
[00:15:09.547] Timer tick, asking Buildbucket for the build status
[00:15:09.626] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:09.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:156:0) after 1m0s
[00:16:09.678] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:156:0)
[00:16:09.678] Timer tick, asking Buildbucket for the build status
[00:16:09.728] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:09.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:157:0) after 1m0s
[00:17:09.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:157:0)
[00:17:09.796] Timer tick, asking Buildbucket for the build status
[00:17:09.895] Build 8933470455861186144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:09.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9098900517980740992:158:0) after 1m0s
[00:17:27.706] Received PubSub notification, asking Buildbucket for the build status
[00:17:27.749] Build 8933470455861186144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:17:27.749] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1538785046504660",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1538775692079330",
"id": "8933470455861186144",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\"}}",
"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/8933470455861186144/+/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\": [\"3801-8761768\"], \"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\": \"82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\", \"recipe\": \"swarming/deterministic_build\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#25026}\", \"$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@{#597312}\", \"branch\": \"refs/heads/master\", \"revision\": \"82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"buildername\": \"Windows deterministic\", \"got_webrtc_revision\": \"ef8a3eb5221c491807457e6e1e55beeb6a94140d\", \"mastername\": \"chromium.fyi\", \"got_angle_revision\": \"78df3362ac219aab600a15b29290f39d36337bc4\", \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1538775692079330, \"tags\": [\"builder:Windows deterministic\", \"buildset:commit/git/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\", \"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9098900517980740992\", \"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\": \"8933470455861186144\"}}, \"got_v8_revision\": \"2cefd9836f16a76645d9cc0500f013d0cc444353\", \"got_v8_revision_cp\": \"refs/heads/7.1.272@{#1}\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildnumber\": 10308, \"swarm_hashes\": {\"shell_dialogs_unittests\": \"c7a12d2e1e607ebe187992129eadd4725070bc62\", \"notification_helper_unittests\": \"45e6d81a823adfaab7ccf6084a28942f31eda6c3\", \"gpu_perftests\": \"608fcf1828a75c9caaaf2796ca625acb573ae0ee\", \"vr_common_unittests\": \"7a60a0875062d782fa9326b2f46701eaa5ee687b\", \"telemetry_unittests\": \"68af4bf99fd59f12f455a4c7fcdbb3278a361e1e\", \"load_library_perf_tests\": \"b1c9506a98bcba18d795c678d3d351803fc7d473\", \"devtools_closure_compile\": \"9f5e13f32e4ef2191854d4b1a86bcc4ed405d7d2\", \"chromedriver_py_tests\": \"ec119cc5765167bce89b0c85af942b5144488e55\", \"mojo_core_unittests\": \"2e41cce0117970fe692237d7dcf6a29d308bbeab\", \"install_static_unittests\": \"2764fefbfcdd127190771d78535f772b72274f26\", \"leveldb_service_unittests\": \"40e61c80617a2223105c36b5f49dd16aa7a5ad66\", \"mini_installer_tests\": \"a76eb40c3387f2cdf4a918e22af9d696e646bfe7\", \"jingle_unittests\": \"6fd9fa19211320f099d8e18b8be937fa618ce471\", \"sbox_integration_tests\": \"8c1c1c5376dc16d23fd3195d3d49b1a25172f74c\", \"angle_unittests\": \"fdb4facbe3943a6e18c603100d56dc0bbbfd1333\", \"cast_unittests\": \"0f213d05ae9458fd6a34142600951f9e6f0d51e4\", \"cc_unittests\": \"e057fc318c23ec428558846066350ae2831303a0\", \"blink_common_unittests\": \"8cbcc343fe49b47ed4cb479e5d98701a5b6c6464\", \"crashpad_tests\": \"f48764fdb3ad7cd7a7b17608ab088b55b2c50d06\", \"telemetry_perf_tests_without_chrome\": \"4967d200a5a26d4f48132d93124e3ce550ccaf2a\", \"metrics_python_tests\": \"b4e4090d7c42df6b958c4a40710412bed7ee9ad6\", \"message_center_unittests\": \"2fc570f1bd97f323d6eed93657169e46201d06b2\", \"ppapi_unittests\": \"f725f6ea883d10ff2a78640e7415ce4d4efda895\", \"extensions_unittests\": \"f9824f2fa822bdb752d15626806229ce52796eed\", \"gl_unittests_ozone\": \"423f5aee0546c2cfcc50d87944d09c0cd89c349c\", \"app_shell_unittests\": \"415cb1a58cab6cc97943ccf03e6a492a7172d319\", \"chrome_app_unittests\": \"7c3be60a054fe5ad6d16b21f96ccbfc0fb19fe00\", \"gl_unittests\": \"423f5aee0546c2cfcc50d87944d09c0cd89c349c\", \"gcm_unit_tests\": \"d18233cb2f86b5424608f721d0e9ffa69ac05d99\", \"views_unittests\": \"9cad40718c8651bfe61bde8745ac5eacfcb06601\", \"content_shell_crash_test\": \"193d6ac42a57419a09cd450b1668693f63bf8234\", \"ui_base_unittests\": \"1510f70a00acc9dc80a17a6f9f568f8278c99097\", \"gles2_conform_test\": \"72b1d21d20c6428ea7b8d4a46d2866b42f60ff25\", \"cronet_unittests\": \"c20b02f619fca2effcf5620a73cd3d94c8b92d95\", \"performance_test_suite\": \"2b591fc803e3c8373b6cd274ed75cdb75d6035c6\", \"wm_unittests\": \"72885e9d01c67e31e4006af8489afadcdb2d7e82\", \"boringssl_crypto_tests\": \"76b00aa8b78058f21ddd777e5fc991a9f7faf440\", \"gin_unittests\": \"09d31928b7d0c63dc942155ce6dbab08395c0a33\", \"performance_browser_tests\": \"09ce483dc0208148735d4d35c7153cfdbdbb4e17\", \"extensions_browsertests\": \"03bfda0571d4815098c5e51f09ec094d449a32bf\", \"webkit_python_tests\": \"1ebacaf42fd19c9e737a312204533c233be0e5fc\", \"headless_unittests\": \"654e1c2b3b9c4ec77b5bf7ef1e3f76a47df36cbd\", \"webkit_layout_tests\": \"57d9c0f3f240cc53437e678b13e53b8c1df3a9dd\", \"vr_pixeltests\": \"728587d56912a2410d64ae1b3049dada4a1c6956\", \"setup_unittests\": \"fd2000c7aa987293a627d640b3c9978ac30e8184\", \"webkit_unit_tests\": \"ce93ecfd0ce7f5d51d45e9445179f753d7813b55\", \"content_unittests\": \"f753ca932d9ee322f658607f6eeb8af635617c29\", \"performance_webview_test_suite\": \"2eed15e2fbb41ee05a5d1b94cafd7ffa16228303\", \"wtf_unittests\": \"adea6a8727c5e6a904230e12b634d19691bb8a04\", \"webkit_layout_tests_exparchive\": \"fee5f0bfd86cd4746fdc4810413403f8a17d7079\", \"chrome_cleaner_unittests\": \"35ec3852653b83337c2d3e03289aa360bfcd2235\", \"traffic_annotation_auditor_unittests\": \"9d54795fe514acc7177c049de26f8a44c8cad36b\", \"libjingle_xmpp_unittests\": \"5243e0023cc94931975d8a1048e63f1e19eb20ad\", \"remoting_unittests\": \"90b077763c75c5b5605a6d094f573d5aa74e4bec\", \"vr_common_perftests\": \"524ae13655c5b180eb0eee18c0f1b39e20a969cc\", \"filesystem_service_unittests\": \"41d97b8acd4c80a5326eadd1e453617324424f63\", \"chrome_elf_import_unittests\": \"07ad21cc5918117aa6693f87c53c64d29a067024\", \"installer_util_unittests\": \"78492af103388d6684882d790480df4ac5720b08\", \"gfx_unittests\": \"1b8eb37297e1507bb3afc7c7cd639e620525c97c\", \"headless_browsertests\": \"db903d72966489f292835f895ed73dd6cf264f4d\", \"capture_unittests\": \"82a3bce2de790ce151094ab1a53c2caff14d0ad0\", \"chrome_elf_unittests\": \"1004a1b1f3dbb0edcac454f5dd3dd08f7d7358d5\", \"telemetry_gpu_unittests\": \"23c413e1a7c43a31f4e0ccb8d385dac4b4d2e4af\", \"command_buffer_perftests\": \"d50638c280a11b83d119b04f483f393b502f2aca\", \"media_unittests\": \"ad8a606dc27008ed1bf0b101e2a295e984bde1a9\", \"chromedriver_unittests\": \"22dc12afffb18bb42a4ed83e87de1c50c5fcd80a\", \"views_mus_interactive_ui_tests\": \"2bad743df5540d6183e46f77c142b870cc9cd42d\", \"storage_unittests\": \"3a28697e1250de200b7e712835ba55cd48cb7da7\", \"media_service_unittests\": \"2156151f5981975ee79a3dd6e672d81550d91662\", \"compositor_unittests\": \"7a7b6a7f73db70c74977397d741c2af0f8d709e1\", \"latency_unittests\": \"bd12e78de8383d5f332ce5d1b061603fd60b28ac\", \"video_decode_accelerator_unittest\": \"f9d8cf1be9a1200832c4a34b8c5546c82cde910a\", \"swiftshader_unittests\": \"5d7fddbc688528b7f4c07ebd04fc2e61773d1829\", \"telemetry_perf_unittests\": \"9db787afac52ac5ffa4880f55835574a5b53c18c\", \"media_blink_unittests\": \"64f5576314e8f6d5745bb7b3802923477657cb9b\", \"views_mus_unittests\": \"3b7bde1ce21ae04a119ddb97b2de3fedd029cba6\", \"components_unittests\": \"47da983c6eb7ec640fde3e21f0d67ac57196e6cf\", \"snapshot_unittests\": \"ca406c0c59f5bff863d96396dbc43d7daf822988\", \"accessibility_unittests\": \"5478a2e78a1d19e165b65346bac6786586f6bf4e\", \"net_perftests\": \"244fd0bd3ccdf77eea525e9f20c3d1de37efa831\", \"aura_unittests\": \"1617612a2cf14ff05e7e274c1f61a922f6d90d82\", \"services_unittests\": \"0627e3b77ce02563e58798f993c40a9f07096d51\", \"components_perftests\": \"e4665cd668d60263937bb8b15e53dab7a03e2861\", \"events_unittests\": \"ed9f0ef2e280dcab74d798a2df986b637e9a3f26\", \"tracing_perftests\": \"adb32e69723867aa1f257ae85d17e8aad864bfba\", \"chromedriver_replay_unittests\": \"5013a0f078eac50a549885e896698d163bf73605\", \"ui_touch_selection_unittests\": \"176e648ce89fe7b647d1d76e909721594c687098\", \"cacheinvalidation_unittests\": \"abe6765495f6b4a7a28bd6c064941c4127771e4d\", \"viz_unittests\": \"9bf03e841ebbe27be743d63b46c484a981c00a40\", \"browser_tests\": \"d60bce847aa184f24ff004f89698e357134e6f50\", \"net_unittests\": \"9a2818148f1608c94f507037cece346a4505d1d6\", \"midi_unittests\": \"31e585719d714b50806a2148d3ee191e8d46e0f2\", \"boringssl_ssl_tests\": \"04a7c75a795271bcf061f279bd666ca2e87e74a5\", \"sbox_validation_tests\": \"69ac120f79c78f51972058640fb5b4d217762f86\", \"elevation_service_unittests\": \"51d5d39bdd47f764b5f8aba34e630e8894d082e0\", \"gpu_unittests\": \"119a0ebfa553b4bc712808d94c6355695b83b7dd\", \"native_theme_unittests\": \"ed00408cc55944221f538c9af3a75ade6cfdbb7a\", \"interactive_ui_tests\": \"ae173d6cad216c55bff2dd06030341bc3a8686f6\", \"mojo_unittests\": \"b5dd206bcc42cc3eee2f2e5827ead0d9d48ca861\", \"url_unittests\": \"0040fd56aeee8bf440880b665f2bbd9525ee4a64\", \"media_perftests\": \"ecd74f794f108784ebe68030752e292ec140e2ab\", \"cronet_tests\": \"21fccde91f042e7d28efc6879be35bd057bef942\", \"google_apis_unittests\": \"f1459ea661a03eaa3181de68f645cc49f9bc3a6d\", \"telemetry_gpu_integration_test\": \"c8fbc25dfa89aa7c49ef0244199459b6341300a2\", \"blink_heap_unittests\": \"20bffea011f34a84c67d07ffb7b3dadf67b57460\", \"base_unittests\": \"5dbcf4f20a782841c678701c5c66df83d50299e7\", \"sync_integration_tests\": \"8837b728e8890ea6f01c704af4c8c05c6b93f406\", \"sql_unittests\": \"0badaff5a06e6e3956974729ce35b1960d55faec\", \"courgette_unittests\": \"b0b685f3602093638ab944e10dc0bb170c1f5144\", \"blink_fuzzer_unittests\": \"7ce46a1ecc2dcccc9a87125c566a4f5c37046e54\", \"gl_tests\": \"59ea14e07c80190aeb9c6765b8a7fb8c2ba7123e\", \"zucchini_unittests\": \"c8a85a4e06570b0bb0689510c28479f8f3424615\", \"ipc_tests\": \"1cd12a80ce476a167f58ec611a0c2c8ca178dd07\", \"angle_end2end_tests\": \"0ec1ba1275c7be08b3bd5b894c1e115cc4f16b58\", \"blink_platform_unittests\": \"c4bce001ed26ecd131abf23769c076925ee763db\", \"components_browsertests\": \"f21dd88201ab25b815a0cfb11f4d20cb1f371934\", \"views_perftests\": \"22e422eee7f5c6258b649cb4f3eadd0070344901\", \"angle_perftests\": \"53a7b80c236fb9b1c8c04cae4c42ee33a8322b3d\", \"display_unittests\": \"b56339b99094b1c42d2f893151f4751893adb789\", \"sbox_unittests\": \"108659137e672b3c7182355d009b76f9999182d5\", \"service_manager_unittests\": \"5a79fc2a9213f92ff9c6f27d08d9d96dad1a08c0\", \"pdf_unittests\": \"2695fbd99ae41c154430229682cdb24bc2905155\", \"skia_unittests\": \"abf544a0a3da874f680bf0fc6a5ae5ba02c4e488\", \"angle_white_box_tests\": \"1fb6a3539430685e22a3e7d0134ad0ec176c5ede\", \"crypto_unittests\": \"d12d2e9e29559748b18d0f28925b03474c16ba48\", \"nacl_loader_unittests\": \"9fe7cbbffe7acfab72a6fbfda0311006d240c583\", \"unit_tests\": \"3710ff3bc67ec5b4fb1c936ed3b694ed461c0912\", \"content_browsertests\": \"232209dbd249661d078aa427e19b6634036ccc07\", \"printing_unittests\": \"f3f270da351c25f6680b385cff9ef1119b07a0e2\", \"device_unittests\": \"71cf86829581abc71b4e4e2ce6673279fa92dd3d\"}, \"path_config\": \"generic\", \"bot_id\": \"swarm2173-c4\", \"got_buildtools_revision\": \"2dff9c9c74e9d732e6fe57c84ef7fd044cc45d96\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1538775694210861",
"status": "COMPLETED",
"status_changed_ts": "1538785047130207",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/10308",
"builder:Windows deterministic",
"buildset:commit/git/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9098900517980740992",
"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/10308",
"swarming_tag:buildbucket_bucket:luci.chromium.ci",
"swarming_tag:buildbucket_build_id:8933470455861186144",
"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/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"swarming_tag:buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/82b25c4bc0384d947d5a9b641d2fcde1fd4b1a9a",
"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/8933470455861186144/+/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:9098900517980740992",
"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:7a2c6a280a68ea7a8c9976d934a89c38009336b9",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:405eff3e86a6f010",
"user_agent:luci-scheduler"
],
"updated_ts": "1538785047131858",
"url": "https://ci.chromium.org/p/chromium/builders/luci.chromium.ci/Windows deterministic/10308",
"utcnow_ts": "1538785047737044"
}
}
[00:17:27.749] Invocation finished in 2h35m57.074783153s with status SUCCEEDED