[14:40:20.983] New invocation is queued and will start shortly
[14:40:23.603] Starting the invocation (attempt 1)
[14:40:23.659] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:40:23.659] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:40:23.659] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9068577031445265536",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"af04a3f1b364ec6f10a80d127c3c0cdb938c01bf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9068577031445265536",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"gitiles_ref:refs/heads/master"
]
}
[14:40:29.828] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1567694427319970",
"id": "8903146964137698144",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"af04a3f1b364ec6f10a80d127c3c0cdb938c01bf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567694429200227",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14639",
"builder:Windows deterministic",
"buildset:commit/git/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068577031445265536",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903146964137698144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1567694429200384",
"url": "https://ci.chromium.org/b/8903146964137698144",
"utcnow_ts": "1567694429800881"
}
}
[14:40:29.828] Task URL: https://ci.chromium.org/b/8903146964137698144
[14:40:29.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:2:0) after 1m0s
[14:40:36.052] Received PubSub notification, asking Buildbucket for the build status
[14:40:36.287] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:29.878] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:2:0)
[14:41:29.878] Timer tick, asking Buildbucket for the build status
[14:41:30.154] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:41:30.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:4:0) after 1m0s
[14:42:30.188] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:4:0)
[14:42:30.188] Timer tick, asking Buildbucket for the build status
[14:42:30.385] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:42:30.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:5:0) after 1m0s
[14:43:30.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:5:0)
[14:43:30.469] Timer tick, asking Buildbucket for the build status
[14:43:30.692] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:43:30.692] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:6:0) after 1m0s
[14:44:30.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:6:0)
[14:44:30.828] Timer tick, asking Buildbucket for the build status
[14:44:31.246] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:44:31.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:7:0) after 1m0s
[14:45:31.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:7:0)
[14:45:31.354] Timer tick, asking Buildbucket for the build status
[14:45:31.490] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:31.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:8:0) after 1m0s
[14:46:31.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:8:0)
[14:46:31.608] Timer tick, asking Buildbucket for the build status
[14:46:31.940] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:31.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:9:0) after 1m0s
[14:47:31.993] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:9:0)
[14:47:31.994] Timer tick, asking Buildbucket for the build status
[14:47:33.226] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:33.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:10:0) after 1m0s
[14:48:33.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:10:0)
[14:48:33.321] Timer tick, asking Buildbucket for the build status
[14:48:33.736] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:33.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:11:0) after 1m0s
[14:49:33.857] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:11:0)
[14:49:33.857] Timer tick, asking Buildbucket for the build status
[14:49:34.097] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:34.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:12:0) after 1m0s
[14:50:34.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:12:0)
[14:50:34.181] Timer tick, asking Buildbucket for the build status
[14:50:34.390] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:34.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:13:0) after 1m0s
[14:51:34.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:13:0)
[14:51:34.446] Timer tick, asking Buildbucket for the build status
[14:51:34.690] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:34.690] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:14:0) after 1m0s
[14:52:34.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:14:0)
[14:52:34.780] Timer tick, asking Buildbucket for the build status
[14:52:36.295] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:15:0) after 1m0s
[14:53:36.366] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:15:0)
[14:53:36.366] Timer tick, asking Buildbucket for the build status
[14:53:36.620] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:36.620] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:16:0) after 1m0s
[14:54:36.705] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:16:0)
[14:54:36.705] Timer tick, asking Buildbucket for the build status
[14:54:36.942] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:36.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:17:0) after 1m0s
[14:55:37.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:17:0)
[14:55:37.005] Timer tick, asking Buildbucket for the build status
[14:55:37.283] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:37.283] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:18:0) after 1m0s
[14:56:37.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:18:0)
[14:56:37.308] Timer tick, asking Buildbucket for the build status
[14:56:37.473] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:37.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:19:0) after 1m0s
[14:57:37.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:19:0)
[14:57:37.598] Timer tick, asking Buildbucket for the build status
[14:57:37.806] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:37.806] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:20:0) after 1m0s
[14:58:37.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:20:0)
[14:58:37.934] Timer tick, asking Buildbucket for the build status
[14:58:38.400] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:38.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:21:0) after 1m0s
[14:59:38.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:21:0)
[14:59:38.453] Timer tick, asking Buildbucket for the build status
[14:59:38.776] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:38.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:22:0) after 1m0s
[15:00:38.869] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:22:0)
[15:00:38.869] Timer tick, asking Buildbucket for the build status
[15:00:39.361] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:39.361] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:23:0) after 1m0s
[15:01:39.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:23:0)
[15:01:39.385] Timer tick, asking Buildbucket for the build status
[15:01:39.539] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:39.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:24:0) after 1m0s
[15:02:39.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:24:0)
[15:02:39.582] Timer tick, asking Buildbucket for the build status
[15:02:40.092] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:40.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:25:0) after 1m0s
[15:03:40.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:25:0)
[15:03:40.307] Timer tick, asking Buildbucket for the build status
[15:03:40.569] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:40.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:26:0) after 1m0s
[15:04:40.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:26:0)
[15:04:40.592] Timer tick, asking Buildbucket for the build status
[15:04:40.811] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:40.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:27:0) after 1m0s
[15:05:40.901] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:27:0)
[15:05:40.901] Timer tick, asking Buildbucket for the build status
[15:05:41.410] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:41.410] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:28:0) after 1m0s
[15:06:41.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:28:0)
[15:06:41.470] Timer tick, asking Buildbucket for the build status
[15:06:41.714] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:41.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:29:0) after 1m0s
[15:07:41.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:29:0)
[15:07:41.814] Timer tick, asking Buildbucket for the build status
[15:07:43.372] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:43.372] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:30:0) after 1m0s
[15:08:43.445] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:30:0)
[15:08:43.445] Timer tick, asking Buildbucket for the build status
[15:08:44.236] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:44.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:31:0) after 1m0s
[15:09:44.331] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:31:0)
[15:09:44.331] Timer tick, asking Buildbucket for the build status
[15:09:44.520] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:44.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:32:0) after 1m0s
[15:10:44.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:32:0)
[15:10:44.964] Timer tick, asking Buildbucket for the build status
[15:10:45.500] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:45.500] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:33:0) after 1m0s
[15:11:45.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:33:0)
[15:11:45.629] Timer tick, asking Buildbucket for the build status
[15:11:46.124] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:46.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:34:0) after 1m0s
[15:12:46.227] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:34:0)
[15:12:46.227] Timer tick, asking Buildbucket for the build status
[15:12:46.609] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:46.609] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:35:0) after 1m0s
[15:13:46.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:35:0)
[15:13:46.826] Timer tick, asking Buildbucket for the build status
[15:13:47.610] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:47.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:36:0) after 1m0s
[15:14:47.761] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:36:0)
[15:14:47.761] Timer tick, asking Buildbucket for the build status
[15:14:48.165] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:48.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:37:0) after 1m0s
[15:15:48.231] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:37:0)
[15:15:48.231] Timer tick, asking Buildbucket for the build status
[15:15:49.233] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:49.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:38:0) after 1m0s
[15:16:49.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:38:0)
[15:16:49.367] Timer tick, asking Buildbucket for the build status
[15:16:49.626] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:49.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:39:0) after 1m0s
[15:17:49.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:39:0)
[15:17:49.758] Timer tick, asking Buildbucket for the build status
[15:17:50.741] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:50.741] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:40:0) after 1m0s
[15:18:50.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:40:0)
[15:18:50.891] Timer tick, asking Buildbucket for the build status
[15:18:52.664] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:52.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:41:0) after 1m0s
[15:19:52.681] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:41:0)
[15:19:52.681] Timer tick, asking Buildbucket for the build status
[15:19:53.334] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:53.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:42:0) after 1m0s
[15:20:53.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:42:0)
[15:20:53.392] Timer tick, asking Buildbucket for the build status
[15:20:53.896] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:53.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:43:0) after 1m0s
[15:21:54.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:43:0)
[15:21:54.063] Timer tick, asking Buildbucket for the build status
[15:21:54.993] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:54.993] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:44:0) after 1m0s
[15:22:55.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:44:0)
[15:22:55.224] Timer tick, asking Buildbucket for the build status
[15:22:55.418] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:55.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:45:0) after 1m0s
[15:23:55.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:45:0)
[15:23:55.443] Timer tick, asking Buildbucket for the build status
[15:23:55.599] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:55.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:46:0) after 1m0s
[15:24:55.622] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:46:0)
[15:24:55.622] Timer tick, asking Buildbucket for the build status
[15:24:55.899] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:55.899] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:47:0) after 1m0s
[15:25:55.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:47:0)
[15:25:55.959] Timer tick, asking Buildbucket for the build status
[15:25:56.154] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:56.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:48:0) after 1m0s
[15:26:56.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:48:0)
[15:26:56.196] Timer tick, asking Buildbucket for the build status
[15:26:59.031] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:59.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:49:0) after 1m0s
[15:27:59.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:49:0)
[15:27:59.299] Timer tick, asking Buildbucket for the build status
[15:27:59.632] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:59.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:50:0) after 1m0s
[15:28:59.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:50:0)
[15:28:59.797] Timer tick, asking Buildbucket for the build status
[15:29:00.316] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:00.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:51:0) after 1m0s
[15:30:00.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:51:0)
[15:30:00.373] Timer tick, asking Buildbucket for the build status
[15:30:00.606] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:00.606] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:52:0) after 1m0s
[15:31:00.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:52:0)
[15:31:00.696] Timer tick, asking Buildbucket for the build status
[15:31:00.877] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:00.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:53:0) after 1m0s
[15:32:00.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:53:0)
[15:32:00.985] Timer tick, asking Buildbucket for the build status
[15:32:01.326] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:01.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:54:0) after 1m0s
[15:33:01.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:54:0)
[15:33:01.348] Timer tick, asking Buildbucket for the build status
[15:33:01.767] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:01.767] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:55:0) after 1m0s
[15:34:01.763] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:55:0)
[15:34:01.763] Timer tick, asking Buildbucket for the build status
[15:34:01.957] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:56:0) after 1m0s
[15:35:01.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:56:0)
[15:35:01.984] Timer tick, asking Buildbucket for the build status
[15:35:02.217] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:02.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:57:0) after 1m0s
[15:36:02.270] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:57:0)
[15:36:02.270] Timer tick, asking Buildbucket for the build status
[15:36:02.841] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:02.841] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:58:0) after 1m0s
[15:37:02.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:58:0)
[15:37:02.884] Timer tick, asking Buildbucket for the build status
[15:37:04.151] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:04.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:59:0) after 1m0s
[15:38:04.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:59:0)
[15:38:04.233] Timer tick, asking Buildbucket for the build status
[15:38:04.444] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:04.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:60:0) after 1m0s
[15:39:04.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:60:0)
[15:39:04.545] Timer tick, asking Buildbucket for the build status
[15:39:05.437] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:05.437] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:61:0) after 1m0s
[15:40:05.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:61:0)
[15:40:05.601] Timer tick, asking Buildbucket for the build status
[15:40:06.669] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:06.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:62:0) after 1m0s
[15:41:06.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:62:0)
[15:41:06.964] Timer tick, asking Buildbucket for the build status
[15:41:07.149] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:07.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:63:0) after 1m0s
[15:42:07.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:63:0)
[15:42:07.211] Timer tick, asking Buildbucket for the build status
[15:42:07.803] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:07.803] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:64:0) after 1m0s
[15:43:07.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:64:0)
[15:43:07.862] Timer tick, asking Buildbucket for the build status
[15:43:08.400] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:08.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:65:0) after 1m0s
[15:44:08.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:65:0)
[15:44:08.513] Timer tick, asking Buildbucket for the build status
[15:44:11.280] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:11.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:66:0) after 1m0s
[15:45:11.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:66:0)
[15:45:11.538] Timer tick, asking Buildbucket for the build status
[15:45:11.772] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:11.772] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:67:0) after 1m0s
[15:46:11.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:67:0)
[15:46:11.837] Timer tick, asking Buildbucket for the build status
[15:46:11.989] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:11.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:68:0) after 1m0s
[15:47:12.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:68:0)
[15:47:12.178] Timer tick, asking Buildbucket for the build status
[15:47:12.400] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:12.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:69:0) after 1m0s
[15:48:12.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:69:0)
[15:48:12.743] Timer tick, asking Buildbucket for the build status
[15:48:13.119] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:13.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:70:0) after 1m0s
[15:49:13.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:70:0)
[15:49:13.448] Timer tick, asking Buildbucket for the build status
[15:49:14.025] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:14.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:71:0) after 1m0s
[15:50:14.247] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:71:0)
[15:50:14.248] Timer tick, asking Buildbucket for the build status
[15:50:14.602] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:14.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:72:0) after 1m0s
[15:51:14.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:72:0)
[15:51:14.835] Timer tick, asking Buildbucket for the build status
[15:51:16.258] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:16.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:73:0) after 1m0s
[15:52:16.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:73:0)
[15:52:16.847] Timer tick, asking Buildbucket for the build status
[15:52:17.031] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:17.031] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:74:0) after 1m0s
[15:53:17.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:74:0)
[15:53:17.152] Timer tick, asking Buildbucket for the build status
[15:53:19.403] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:19.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:75:0) after 1m0s
[15:54:19.492] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:75:0)
[15:54:19.492] Timer tick, asking Buildbucket for the build status
[15:54:19.738] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:19.738] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:76:0) after 1m0s
[15:55:19.840] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:76:0)
[15:55:19.840] Timer tick, asking Buildbucket for the build status
[15:55:20.136] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:20.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:77:0) after 1m0s
[15:56:20.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:77:0)
[15:56:20.134] Timer tick, asking Buildbucket for the build status
[15:56:20.514] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:20.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:78:0) after 1m0s
[15:57:20.540] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:78:0)
[15:57:20.540] Timer tick, asking Buildbucket for the build status
[15:57:20.815] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:20.815] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:79:0) after 1m0s
[15:58:20.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:79:0)
[15:58:20.944] Timer tick, asking Buildbucket for the build status
[15:58:21.158] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:21.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:80:0) after 1m0s
[15:59:21.499] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:80:0)
[15:59:21.499] Timer tick, asking Buildbucket for the build status
[15:59:21.742] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:21.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:81:0) after 1m0s
[16:00:22.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:81:0)
[16:00:22.092] Timer tick, asking Buildbucket for the build status
[16:00:22.526] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:22.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:82:0) after 1m0s
[16:01:22.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:82:0)
[16:01:22.558] Timer tick, asking Buildbucket for the build status
[16:01:22.765] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:22.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:83:0) after 1m0s
[16:02:22.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:83:0)
[16:02:22.846] Timer tick, asking Buildbucket for the build status
[16:02:23.168] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:23.168] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:84:0) after 1m0s
[16:03:23.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:84:0)
[16:03:23.237] Timer tick, asking Buildbucket for the build status
[16:03:23.427] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:23.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:85:0) after 1m0s
[16:04:23.574] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:85:0)
[16:04:23.574] Timer tick, asking Buildbucket for the build status
[16:04:24.432] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:24.432] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:86:0) after 1m0s
[16:05:24.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:86:0)
[16:05:24.500] Timer tick, asking Buildbucket for the build status
[16:05:26.130] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:26.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:87:0) after 1m0s
[16:06:26.354] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:87:0)
[16:06:26.354] Timer tick, asking Buildbucket for the build status
[16:06:27.041] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:27.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:88:0) after 1m0s
[16:07:27.374] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:88:0)
[16:07:27.374] Timer tick, asking Buildbucket for the build status
[16:07:28.251] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:28.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:89:0) after 1m0s
[16:08:28.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:89:0)
[16:08:28.624] Timer tick, asking Buildbucket for the build status
[16:08:28.828] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:28.828] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:90:0) after 1m0s
[16:09:28.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:90:0)
[16:09:28.892] Timer tick, asking Buildbucket for the build status
[16:09:29.332] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:29.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:91:0) after 1m0s
[16:10:29.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:91:0)
[16:10:29.822] Timer tick, asking Buildbucket for the build status
[16:10:31.543] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:31.543] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:92:0) after 1m0s
[16:11:32.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:92:0)
[16:11:32.290] Timer tick, asking Buildbucket for the build status
[16:11:32.496] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:32.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:93:0) after 1m0s
[16:12:32.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:93:0)
[16:12:32.688] Timer tick, asking Buildbucket for the build status
[16:12:33.104] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:33.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:94:0) after 1m0s
[16:13:33.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:94:0)
[16:13:33.174] Timer tick, asking Buildbucket for the build status
[16:13:33.357] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:33.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:95:0) after 1m0s
[16:14:33.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:95:0)
[16:14:33.484] Timer tick, asking Buildbucket for the build status
[16:14:34.334] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:34.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:96:0) after 1m0s
[16:15:34.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:96:0)
[16:15:34.333] Timer tick, asking Buildbucket for the build status
[16:15:35.405] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:35.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:97:0) after 1m0s
[16:16:35.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:97:0)
[16:16:35.555] Timer tick, asking Buildbucket for the build status
[16:16:35.782] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:35.782] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:98:0) after 1m0s
[16:17:36.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:98:0)
[16:17:36.045] Timer tick, asking Buildbucket for the build status
[16:17:36.414] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:36.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:99:0) after 1m0s
[16:18:36.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:99:0)
[16:18:36.453] Timer tick, asking Buildbucket for the build status
[16:18:37.178] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:37.178] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:100:0) after 1m0s
[16:19:37.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:100:0)
[16:19:37.412] Timer tick, asking Buildbucket for the build status
[16:19:39.141] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:39.141] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:101:0) after 1m0s
[16:20:39.148] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:101:0)
[16:20:39.148] Timer tick, asking Buildbucket for the build status
[16:20:40.527] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:40.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:102:0) after 1m0s
[16:21:40.567] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:102:0)
[16:21:40.567] Timer tick, asking Buildbucket for the build status
[16:21:40.766] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:40.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:103:0) after 1m0s
[16:22:40.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:103:0)
[16:22:40.804] Timer tick, asking Buildbucket for the build status
[16:22:41.052] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:41.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:104:0) after 1m0s
[16:23:41.124] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:104:0)
[16:23:41.124] Timer tick, asking Buildbucket for the build status
[16:23:41.526] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:41.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:105:0) after 1m0s
[16:24:41.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:105:0)
[16:24:41.529] Timer tick, asking Buildbucket for the build status
[16:24:42.568] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:42.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:106:0) after 1m0s
[16:25:42.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:106:0)
[16:25:42.683] Timer tick, asking Buildbucket for the build status
[16:25:42.889] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:42.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:107:0) after 1m0s
[16:26:42.958] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:107:0)
[16:26:42.958] Timer tick, asking Buildbucket for the build status
[16:26:43.141] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:43.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:108:0) after 1m0s
[16:27:43.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:108:0)
[16:27:43.230] Timer tick, asking Buildbucket for the build status
[16:27:43.675] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:43.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:109:0) after 1m0s
[16:28:43.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:109:0)
[16:28:43.737] Timer tick, asking Buildbucket for the build status
[16:28:44.406] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:44.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:110:0) after 1m0s
[16:29:44.711] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:110:0)
[16:29:44.711] Timer tick, asking Buildbucket for the build status
[16:29:45.631] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:45.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:111:0) after 1m0s
[16:30:45.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:111:0)
[16:30:45.642] Timer tick, asking Buildbucket for the build status
[16:30:46.542] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:46.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:112:0) after 1m0s
[16:31:46.653] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:112:0)
[16:31:46.653] Timer tick, asking Buildbucket for the build status
[16:31:47.051] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:47.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:113:0) after 1m0s
[16:32:47.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:113:0)
[16:32:47.068] Timer tick, asking Buildbucket for the build status
[16:32:47.494] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:47.494] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:114:0) after 1m0s
[16:33:47.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:114:0)
[16:33:47.533] Timer tick, asking Buildbucket for the build status
[16:33:48.216] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:48.216] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:115:0) after 1m0s
[16:34:48.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:115:0)
[16:34:48.264] Timer tick, asking Buildbucket for the build status
[16:34:48.988] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:48.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:116:0) after 1m0s
[16:35:49.109] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:116:0)
[16:35:49.109] Timer tick, asking Buildbucket for the build status
[16:35:49.317] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:49.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:117:0) after 1m0s
[16:36:49.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:117:0)
[16:36:49.343] Timer tick, asking Buildbucket for the build status
[16:36:50.357] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:50.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:118:0) after 1m0s
[16:37:50.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:118:0)
[16:37:50.511] Timer tick, asking Buildbucket for the build status
[16:37:50.926] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:50.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:119:0) after 1m0s
[16:38:51.172] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:119:0)
[16:38:51.172] Timer tick, asking Buildbucket for the build status
[16:38:53.770] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:53.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:120:0) after 1m0s
[16:39:53.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:120:0)
[16:39:53.813] Timer tick, asking Buildbucket for the build status
[16:39:53.969] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:53.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:121:0) after 1m0s
[16:40:54.014] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:121:0)
[16:40:54.014] Timer tick, asking Buildbucket for the build status
[16:40:55.165] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:55.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:122:0) after 1m0s
[16:41:55.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:122:0)
[16:41:55.190] Timer tick, asking Buildbucket for the build status
[16:41:55.401] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:55.401] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:123:0) after 1m0s
[16:42:55.439] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:123:0)
[16:42:55.439] Timer tick, asking Buildbucket for the build status
[16:42:56.231] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:56.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:124:0) after 1m0s
[16:43:56.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:124:0)
[16:43:56.299] Timer tick, asking Buildbucket for the build status
[16:43:56.617] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:56.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:125:0) after 1m0s
[16:44:56.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:125:0)
[16:44:56.911] Timer tick, asking Buildbucket for the build status
[16:44:57.705] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:57.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:126:0) after 1m0s
[16:45:57.850] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:126:0)
[16:45:57.850] Timer tick, asking Buildbucket for the build status
[16:46:04.447] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:04.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:127:0) after 1m0s
[16:47:04.578] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:127:0)
[16:47:04.578] Timer tick, asking Buildbucket for the build status
[16:47:04.854] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:04.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:128:0) after 1m0s
[16:48:05.009] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:128:0)
[16:48:05.009] Timer tick, asking Buildbucket for the build status
[16:48:06.294] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:06.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:129:0) after 1m0s
[16:49:06.343] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:129:0)
[16:49:06.343] Timer tick, asking Buildbucket for the build status
[16:49:07.482] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:07.482] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:130:0) after 1m0s
[16:50:07.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:130:0)
[16:50:07.508] Timer tick, asking Buildbucket for the build status
[16:50:07.959] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:07.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:131:0) after 1m0s
[16:51:07.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:131:0)
[16:51:07.984] Timer tick, asking Buildbucket for the build status
[16:51:08.265] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:08.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:132:0) after 1m0s
[16:52:08.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:132:0)
[16:52:08.347] Timer tick, asking Buildbucket for the build status
[16:52:09.496] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:09.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:133:0) after 1m0s
[16:53:09.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:133:0)
[16:53:09.533] Timer tick, asking Buildbucket for the build status
[16:53:09.827] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:09.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:134:0) after 1m0s
[16:54:09.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:134:0)
[16:54:09.940] Timer tick, asking Buildbucket for the build status
[16:54:10.157] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:10.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:135:0) after 1m0s
[16:55:10.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:135:0)
[16:55:10.198] Timer tick, asking Buildbucket for the build status
[16:55:10.542] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:10.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:136:0) after 1m0s
[16:56:10.580] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:136:0)
[16:56:10.580] Timer tick, asking Buildbucket for the build status
[16:56:10.747] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:10.747] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:137:0) after 1m0s
[16:57:10.783] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:137:0)
[16:57:10.783] Timer tick, asking Buildbucket for the build status
[16:57:11.038] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:11.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:138:0) after 1m0s
[16:58:11.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:138:0)
[16:58:11.112] Timer tick, asking Buildbucket for the build status
[16:58:11.765] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:11.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:139:0) after 1m0s
[16:59:11.828] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:139:0)
[16:59:11.828] Timer tick, asking Buildbucket for the build status
[16:59:12.007] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:12.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:140:0) after 1m0s
[17:00:12.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:140:0)
[17:00:12.040] Timer tick, asking Buildbucket for the build status
[17:00:12.311] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:12.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:141:0) after 1m0s
[17:01:12.367] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:141:0)
[17:01:12.367] Timer tick, asking Buildbucket for the build status
[17:01:12.716] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:12.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:142:0) after 1m0s
[17:02:12.871] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:142:0)
[17:02:12.871] Timer tick, asking Buildbucket for the build status
[17:02:13.172] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:13.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:143:0) after 1m0s
[17:03:13.332] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:143:0)
[17:03:13.332] Timer tick, asking Buildbucket for the build status
[17:03:14.049] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:144:0) after 1m0s
[17:04:14.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:144:0)
[17:04:14.149] Timer tick, asking Buildbucket for the build status
[17:04:15.019] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:15.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:145:0) after 1m0s
[17:05:15.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:145:0)
[17:05:15.059] Timer tick, asking Buildbucket for the build status
[17:05:15.586] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:15.586] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:146:0) after 1m0s
[17:06:15.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:146:0)
[17:06:15.646] Timer tick, asking Buildbucket for the build status
[17:06:16.486] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:16.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:147:0) after 1m0s
[17:07:16.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:147:0)
[17:07:16.542] Timer tick, asking Buildbucket for the build status
[17:07:17.307] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:17.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:148:0) after 1m0s
[17:08:17.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:148:0)
[17:08:17.365] Timer tick, asking Buildbucket for the build status
[17:08:17.873] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:17.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:149:0) after 1m0s
[17:09:17.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:149:0)
[17:09:17.907] Timer tick, asking Buildbucket for the build status
[17:09:18.453] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:18.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:150:0) after 1m0s
[17:10:18.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:150:0)
[17:10:18.525] Timer tick, asking Buildbucket for the build status
[17:10:18.921] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:18.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:151:0) after 1m0s
[17:11:19.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:151:0)
[17:11:19.136] Timer tick, asking Buildbucket for the build status
[17:11:21.685] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:21.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:152:0) after 1m0s
[17:12:21.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:152:0)
[17:12:21.747] Timer tick, asking Buildbucket for the build status
[17:12:22.406] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:22.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:153:0) after 1m0s
[17:13:22.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:153:0)
[17:13:22.523] Timer tick, asking Buildbucket for the build status
[17:13:23.084] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:154:0) after 1m0s
[17:14:23.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:154:0)
[17:14:23.149] Timer tick, asking Buildbucket for the build status
[17:14:24.911] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:24.911] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:155:0) after 1m0s
[17:15:24.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:155:0)
[17:15:24.976] Timer tick, asking Buildbucket for the build status
[17:15:25.565] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:25.565] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:156:0) after 1m0s
[17:16:25.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:156:0)
[17:16:25.560] Timer tick, asking Buildbucket for the build status
[17:16:26.574] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:26.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:157:0) after 1m0s
[17:17:26.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:157:0)
[17:17:26.665] Timer tick, asking Buildbucket for the build status
[17:17:26.879] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:26.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:158:0) after 1m0s
[17:18:27.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:158:0)
[17:18:27.068] Timer tick, asking Buildbucket for the build status
[17:18:27.346] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:27.346] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:159:0) after 1m0s
[17:19:27.409] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:159:0)
[17:19:27.409] Timer tick, asking Buildbucket for the build status
[17:19:28.310] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:28.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:160:0) after 1m0s
[17:20:28.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:160:0)
[17:20:28.349] Timer tick, asking Buildbucket for the build status
[17:20:28.995] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:28.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:161:0) after 1m0s
[17:21:29.077] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:161:0)
[17:21:29.077] Timer tick, asking Buildbucket for the build status
[17:21:29.291] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:29.291] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:162:0) after 1m0s
[17:22:29.377] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:162:0)
[17:22:29.377] Timer tick, asking Buildbucket for the build status
[17:22:29.703] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:29.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:163:0) after 1m0s
[17:23:29.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:163:0)
[17:23:29.737] Timer tick, asking Buildbucket for the build status
[17:23:31.557] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:31.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:164:0) after 1m0s
[17:24:31.571] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:164:0)
[17:24:31.571] Timer tick, asking Buildbucket for the build status
[17:24:32.700] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:32.700] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:165:0) after 1m0s
[17:25:32.770] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:165:0)
[17:25:32.770] Timer tick, asking Buildbucket for the build status
[17:25:33.250] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:33.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:166:0) after 1m0s
[17:26:33.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:166:0)
[17:26:33.250] Timer tick, asking Buildbucket for the build status
[17:26:34.968] Build 8903146964137698144: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:34.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9068577031445265536:167:0) after 1m0s
[17:27:03.021] Received PubSub notification, asking Buildbucket for the build status
[17:27:03.784] Build 8903146964137698144: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:27:03.784] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1567704417240116",
"created_by": "project:chromium",
"created_ts": "1567694427319970",
"id": "8903146964137698144",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"af04a3f1b364ec6f10a80d127c3c0cdb938c01bf\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"windows-deterministic-0-y5mg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14639, \"got_angle_revision\": \"d0e56cc64289aecbecd3de139d7b47c1e47e2158\", \"got_dawn_revision\": \"a900ccebcf428c99184ca44a3fad6030b2e43fc7\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"af04a3f1b364ec6f10a80d127c3c0cdb938c01bf\", \"got_revision_cp\": \"refs/heads/master@{#693719}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"73694fd32996da7f914e05ebc84aa9fbe2cd6b52\", \"got_v8_revision_cp\": \"refs/heads/7.8.279@{#1}\", \"got_webrtc_revision\": \"5b728cca77c46ed47ae589acba676485a957070b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29078}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"af04a3f1b364ec6f10a80d127c3c0cdb938c01bf\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-y5mg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4417-ad2503b\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567694435179954",
"status": "COMPLETED",
"status_changed_ts": "1567704417674385",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14639",
"builder:Windows deterministic",
"buildset:commit/git/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/af04a3f1b364ec6f10a80d127c3c0cdb938c01bf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9068577031445265536",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8903146964137698144/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:471ab026c595a510",
"user_agent:luci-scheduler"
],
"updated_ts": "1567704417679675",
"url": "https://ci.chromium.org/b/8903146964137698144",
"utcnow_ts": "1567704423730942"
}
}
[17:27:03.784] Invocation finished in 2h46m42.817041793s with status SUCCEEDED