[10:58:16.824] New invocation is queued and will start shortly
[10:58:18.256] Starting the invocation (attempt 1)
[10:58:18.327] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:58:18.327] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:58:18.327] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9071037120939254944",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"032c3bea76deafdebb369016a488367a093dbcaf\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9071037120939254944",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/032c3bea76deafdebb369016a488367a093dbcaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/032c3bea76deafdebb369016a488367a093dbcaf",
"gitiles_ref:refs/heads/master"
]
}
[10:58:19.976] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1565348298889520",
"id": "8905607058102855136",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"032c3bea76deafdebb369016a488367a093dbcaf\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1565348299781042",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14374",
"builder:Windows deterministic",
"buildset:commit/git/032c3bea76deafdebb369016a488367a093dbcaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/032c3bea76deafdebb369016a488367a093dbcaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071037120939254944",
"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/8905607058102855136/+/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": "1565348299781135",
"url": "https://ci.chromium.org/b/8905607058102855136",
"utcnow_ts": "1565348299959206"
}
}
[10:58:19.976] Task URL: https://ci.chromium.org/b/8905607058102855136
[10:58:19.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:2:0) after 1m0s
[10:58:29.138] Received PubSub notification, asking Buildbucket for the build status
[10:58:29.288] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:20.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:2:0)
[10:59:20.084] Timer tick, asking Buildbucket for the build status
[10:59:20.737] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:20.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:4:0) after 1m0s
[11:00:20.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:4:0)
[11:00:20.854] Timer tick, asking Buildbucket for the build status
[11:00:26.269] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:26.270] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:5:0) after 1m0s
[11:01:26.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:5:0)
[11:01:26.302] Timer tick, asking Buildbucket for the build status
[11:01:26.505] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:26.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:6:0) after 1m0s
[11:02:26.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:6:0)
[11:02:26.715] Timer tick, asking Buildbucket for the build status
[11:02:26.902] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:26.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:7:0) after 1m0s
[11:03:26.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:7:0)
[11:03:26.990] Timer tick, asking Buildbucket for the build status
[11:03:27.258] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:27.258] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:8:0) after 1m0s
[11:04:27.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:8:0)
[11:04:27.336] Timer tick, asking Buildbucket for the build status
[11:04:27.527] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:27.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:9:0) after 1m0s
[11:05:27.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:9:0)
[11:05:27.647] Timer tick, asking Buildbucket for the build status
[11:05:28.332] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:28.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:10:0) after 1m0s
[11:06:28.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:10:0)
[11:06:28.437] Timer tick, asking Buildbucket for the build status
[11:06:28.632] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:28.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:11:0) after 1m0s
[11:07:28.691] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:11:0)
[11:07:28.691] Timer tick, asking Buildbucket for the build status
[11:07:29.152] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:29.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:12:0) after 1m0s
[11:08:29.220] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:12:0)
[11:08:29.220] Timer tick, asking Buildbucket for the build status
[11:08:29.463] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:29.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:13:0) after 1m0s
[11:09:29.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:13:0)
[11:09:29.566] Timer tick, asking Buildbucket for the build status
[11:09:30.450] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:30.450] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:14:0) after 1m0s
[11:10:30.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:14:0)
[11:10:30.479] Timer tick, asking Buildbucket for the build status
[11:10:30.715] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:30.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:15:0) after 1m0s
[11:11:30.759] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:15:0)
[11:11:30.759] Timer tick, asking Buildbucket for the build status
[11:11:31.514] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:31.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:16:0) after 1m0s
[11:12:31.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:16:0)
[11:12:31.538] Timer tick, asking Buildbucket for the build status
[11:12:31.867] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:31.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:17:0) after 1m0s
[11:13:32.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:17:0)
[11:13:32.017] Timer tick, asking Buildbucket for the build status
[11:13:32.252] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:32.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:18:0) after 1m0s
[11:14:32.395] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:18:0)
[11:14:32.395] Timer tick, asking Buildbucket for the build status
[11:14:32.755] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:32.755] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:19:0) after 1m0s
[11:15:33.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:19:0)
[11:15:33.007] Timer tick, asking Buildbucket for the build status
[11:15:33.227] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:33.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:20:0) after 1m0s
[11:16:33.413] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:20:0)
[11:16:33.413] Timer tick, asking Buildbucket for the build status
[11:16:33.732] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:33.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:21:0) after 1m0s
[11:17:33.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:21:0)
[11:17:33.912] Timer tick, asking Buildbucket for the build status
[11:17:34.217] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:34.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:22:0) after 1m0s
[11:18:34.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:22:0)
[11:18:34.348] Timer tick, asking Buildbucket for the build status
[11:18:34.660] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:34.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:23:0) after 1m0s
[11:19:34.959] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:23:0)
[11:19:34.959] Timer tick, asking Buildbucket for the build status
[11:19:35.157] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:35.157] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:24:0) after 1m0s
[11:20:35.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:24:0)
[11:20:35.226] Timer tick, asking Buildbucket for the build status
[11:20:37.495] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:37.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:25:0) after 1m0s
[11:21:37.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:25:0)
[11:21:37.623] Timer tick, asking Buildbucket for the build status
[11:21:37.874] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:37.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:26:0) after 1m0s
[11:22:37.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:26:0)
[11:22:37.894] Timer tick, asking Buildbucket for the build status
[11:22:38.422] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:38.422] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:27:0) after 1m0s
[11:23:38.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:27:0)
[11:23:38.478] Timer tick, asking Buildbucket for the build status
[11:23:38.820] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:38.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:28:0) after 1m0s
[11:24:38.889] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:28:0)
[11:24:38.889] Timer tick, asking Buildbucket for the build status
[11:24:39.139] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:39.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:29:0) after 1m0s
[11:25:39.229] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:29:0)
[11:25:39.229] Timer tick, asking Buildbucket for the build status
[11:25:39.475] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:39.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:30:0) after 1m0s
[11:26:39.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:30:0)
[11:26:39.531] Timer tick, asking Buildbucket for the build status
[11:26:39.783] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:39.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:31:0) after 1m0s
[11:27:39.810] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:31:0)
[11:27:39.810] Timer tick, asking Buildbucket for the build status
[11:27:40.557] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:40.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:32:0) after 1m0s
[11:28:40.601] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:32:0)
[11:28:40.601] Timer tick, asking Buildbucket for the build status
[11:28:40.796] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:40.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:33:0) after 1m0s
[11:29:40.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:33:0)
[11:29:40.818] Timer tick, asking Buildbucket for the build status
[11:29:44.981] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:44.981] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:34:0) after 1m0s
[11:30:45.007] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:34:0)
[11:30:45.007] Timer tick, asking Buildbucket for the build status
[11:30:46.028] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:46.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:35:0) after 1m0s
[11:31:46.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:35:0)
[11:31:46.054] Timer tick, asking Buildbucket for the build status
[11:31:47.839] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:47.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:36:0) after 1m0s
[11:32:47.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:36:0)
[11:32:47.867] Timer tick, asking Buildbucket for the build status
[11:32:48.052] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:48.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:37:0) after 1m0s
[11:33:48.076] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:37:0)
[11:33:48.076] Timer tick, asking Buildbucket for the build status
[11:33:48.268] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:48.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:38:0) after 1m0s
[11:34:48.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:38:0)
[11:34:48.300] Timer tick, asking Buildbucket for the build status
[11:34:48.519] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:48.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:39:0) after 1m0s
[11:35:48.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:39:0)
[11:35:48.546] Timer tick, asking Buildbucket for the build status
[11:35:49.225] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:49.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:40:0) after 1m0s
[11:36:49.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:40:0)
[11:36:49.336] Timer tick, asking Buildbucket for the build status
[11:36:49.575] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:49.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:41:0) after 1m0s
[11:37:49.597] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:41:0)
[11:37:49.597] Timer tick, asking Buildbucket for the build status
[11:37:50.082] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:50.082] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:42:0) after 1m0s
[11:38:50.139] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:42:0)
[11:38:50.139] Timer tick, asking Buildbucket for the build status
[11:38:50.902] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:50.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:43:0) after 1m0s
[11:39:50.947] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:43:0)
[11:39:50.947] Timer tick, asking Buildbucket for the build status
[11:39:51.152] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:51.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:44:0) after 1m0s
[11:40:51.145] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:44:0)
[11:40:51.145] Timer tick, asking Buildbucket for the build status
[11:40:51.392] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:51.392] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:45:0) after 1m0s
[11:41:51.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:45:0)
[11:41:51.433] Timer tick, asking Buildbucket for the build status
[11:41:51.661] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:51.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:46:0) after 1m0s
[11:42:51.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:46:0)
[11:42:51.652] Timer tick, asking Buildbucket for the build status
[11:42:51.976] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:51.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:47:0) after 1m0s
[11:43:52.211] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:47:0)
[11:43:52.212] Timer tick, asking Buildbucket for the build status
[11:43:52.325] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:52.325] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:48:0) after 1m0s
[11:44:52.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:48:0)
[11:44:52.380] Timer tick, asking Buildbucket for the build status
[11:44:52.939] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:52.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:49:0) after 1m0s
[11:45:52.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:49:0)
[11:45:52.956] Timer tick, asking Buildbucket for the build status
[11:45:53.136] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:53.136] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:50:0) after 1m0s
[11:46:53.133] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:50:0)
[11:46:53.133] Timer tick, asking Buildbucket for the build status
[11:46:53.303] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:53.303] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:51:0) after 1m0s
[11:47:53.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:51:0)
[11:47:53.365] Timer tick, asking Buildbucket for the build status
[11:47:57.077] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:57.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:52:0) after 1m0s
[11:48:57.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:52:0)
[11:48:57.063] Timer tick, asking Buildbucket for the build status
[11:48:57.261] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:57.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:53:0) after 1m0s
[11:49:57.290] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:53:0)
[11:49:57.290] Timer tick, asking Buildbucket for the build status
[11:49:57.811] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:57.811] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:54:0) after 1m0s
[11:50:57.808] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:54:0)
[11:50:57.808] Timer tick, asking Buildbucket for the build status
[11:50:57.961] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:57.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:55:0) after 1m0s
[11:51:58.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:55:0)
[11:51:58.102] Timer tick, asking Buildbucket for the build status
[11:51:58.315] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:58.315] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:56:0) after 1m0s
[11:52:58.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:56:0)
[11:52:58.624] Timer tick, asking Buildbucket for the build status
[11:52:58.929] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:58.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:57:0) after 1m0s
[11:53:59.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:57:0)
[11:53:59.074] Timer tick, asking Buildbucket for the build status
[11:53:59.295] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:59.295] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:58:0) after 1m0s
[11:54:59.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:58:0)
[11:54:59.388] Timer tick, asking Buildbucket for the build status
[11:55:00.314] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:00.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:59:0) after 1m0s
[11:56:00.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:59:0)
[11:56:00.435] Timer tick, asking Buildbucket for the build status
[11:56:01.955] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:01.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:60:0) after 1m0s
[11:57:02.115] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:60:0)
[11:57:02.115] Timer tick, asking Buildbucket for the build status
[11:57:02.311] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:02.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:61:0) after 1m0s
[11:58:02.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:61:0)
[11:58:02.519] Timer tick, asking Buildbucket for the build status
[11:58:02.639] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:02.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:62:0) after 1m0s
[11:59:02.737] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:62:0)
[11:59:02.737] Timer tick, asking Buildbucket for the build status
[11:59:02.925] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:02.925] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:63:0) after 1m0s
[12:00:03.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:63:0)
[12:00:03.043] Timer tick, asking Buildbucket for the build status
[12:00:03.589] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:03.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:64:0) after 1m0s
[12:01:03.629] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:64:0)
[12:01:03.629] Timer tick, asking Buildbucket for the build status
[12:01:04.257] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:04.257] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:65:0) after 1m0s
[12:02:04.433] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:65:0)
[12:02:04.433] Timer tick, asking Buildbucket for the build status
[12:02:04.703] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:04.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:66:0) after 1m0s
[12:03:04.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:66:0)
[12:03:04.816] Timer tick, asking Buildbucket for the build status
[12:03:06.130] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:06.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:67:0) after 1m0s
[12:04:06.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:67:0)
[12:04:06.502] Timer tick, asking Buildbucket for the build status
[12:04:07.202] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:68:0) after 1m0s
[12:05:07.232] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:68:0)
[12:05:07.232] Timer tick, asking Buildbucket for the build status
[12:05:08.354] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:08.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:69:0) after 1m0s
[12:06:08.427] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:69:0)
[12:06:08.427] Timer tick, asking Buildbucket for the build status
[12:06:08.615] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:08.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:70:0) after 1m0s
[12:07:08.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:70:0)
[12:07:08.773] Timer tick, asking Buildbucket for the build status
[12:07:09.423] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:09.423] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:71:0) after 1m0s
[12:08:09.417] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:71:0)
[12:08:09.417] Timer tick, asking Buildbucket for the build status
[12:08:12.949] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:12.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:72:0) after 1m0s
[12:09:12.985] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:72:0)
[12:09:12.985] Timer tick, asking Buildbucket for the build status
[12:09:15.079] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:15.079] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:73:0) after 1m0s
[12:10:15.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:73:0)
[12:10:15.174] Timer tick, asking Buildbucket for the build status
[12:10:16.167] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:16.167] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:74:0) after 1m0s
[12:11:16.178] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:74:0)
[12:11:16.178] Timer tick, asking Buildbucket for the build status
[12:11:20.941] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:20.941] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:75:0) after 1m0s
[12:12:21.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:75:0)
[12:12:21.018] Timer tick, asking Buildbucket for the build status
[12:12:23.520] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:76:0) after 1m0s
[12:13:23.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:76:0)
[12:13:23.664] Timer tick, asking Buildbucket for the build status
[12:13:24.230] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:24.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:77:0) after 1m0s
[12:14:24.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:77:0)
[12:14:24.334] Timer tick, asking Buildbucket for the build status
[12:14:24.484] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:24.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:78:0) after 1m0s
[12:15:24.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:78:0)
[12:15:24.593] Timer tick, asking Buildbucket for the build status
[12:15:24.871] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:24.871] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:79:0) after 1m0s
[12:16:24.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:79:0)
[12:16:24.899] Timer tick, asking Buildbucket for the build status
[12:16:26.320] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:26.320] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:80:0) after 1m0s
[12:17:26.448] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:80:0)
[12:17:26.448] Timer tick, asking Buildbucket for the build status
[12:17:27.100] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:27.100] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:81:0) after 1m0s
[12:18:27.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:81:0)
[12:18:27.219] Timer tick, asking Buildbucket for the build status
[12:18:27.366] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:27.366] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:82:0) after 1m0s
[12:19:27.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:82:0)
[12:19:27.493] Timer tick, asking Buildbucket for the build status
[12:19:28.019] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:28.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:83:0) after 1m0s
[12:20:28.153] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:83:0)
[12:20:28.153] Timer tick, asking Buildbucket for the build status
[12:20:28.490] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:28.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:84:0) after 1m0s
[12:21:28.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:84:0)
[12:21:28.592] Timer tick, asking Buildbucket for the build status
[12:21:31.378] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:31.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:85:0) after 1m0s
[12:22:31.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:85:0)
[12:22:31.398] Timer tick, asking Buildbucket for the build status
[12:22:33.862] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:33.862] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:86:0) after 1m0s
[12:23:33.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:86:0)
[12:23:33.921] Timer tick, asking Buildbucket for the build status
[12:23:34.870] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:34.870] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:87:0) after 1m0s
[12:24:34.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:87:0)
[12:24:34.940] Timer tick, asking Buildbucket for the build status
[12:24:35.197] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:35.197] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:88:0) after 1m0s
[12:25:35.241] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:88:0)
[12:25:35.241] Timer tick, asking Buildbucket for the build status
[12:25:35.498] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:35.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:89:0) after 1m0s
[12:26:35.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:89:0)
[12:26:35.714] Timer tick, asking Buildbucket for the build status
[12:26:36.433] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:36.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:90:0) after 1m0s
[12:27:36.609] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:90:0)
[12:27:36.609] Timer tick, asking Buildbucket for the build status
[12:27:37.298] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:37.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:91:0) after 1m0s
[12:28:37.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:91:0)
[12:28:37.357] Timer tick, asking Buildbucket for the build status
[12:28:37.485] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:37.485] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:92:0) after 1m0s
[12:29:37.516] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:92:0)
[12:29:37.516] Timer tick, asking Buildbucket for the build status
[12:29:38.152] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:38.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:93:0) after 1m0s
[12:30:38.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:93:0)
[12:30:38.303] Timer tick, asking Buildbucket for the build status
[12:30:39.038] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.038] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:94:0) after 1m0s
[12:31:39.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:94:0)
[12:31:39.289] Timer tick, asking Buildbucket for the build status
[12:31:39.677] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:39.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:95:0) after 1m0s
[12:32:39.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:95:0)
[12:32:39.751] Timer tick, asking Buildbucket for the build status
[12:32:39.886] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:39.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:96:0) after 1m0s
[12:33:39.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:96:0)
[12:33:39.917] Timer tick, asking Buildbucket for the build status
[12:33:40.059] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:40.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:97:0) after 1m0s
[12:34:40.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:97:0)
[12:34:40.203] Timer tick, asking Buildbucket for the build status
[12:34:40.489] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:40.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:98:0) after 1m0s
[12:35:40.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:98:0)
[12:35:40.555] Timer tick, asking Buildbucket for the build status
[12:35:41.091] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:41.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:99:0) after 1m0s
[12:36:41.187] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:99:0)
[12:36:41.187] Timer tick, asking Buildbucket for the build status
[12:36:41.901] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:41.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:100:0) after 1m0s
[12:37:42.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:100:0)
[12:37:42.073] Timer tick, asking Buildbucket for the build status
[12:37:42.214] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:42.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:101:0) after 1m0s
[12:38:42.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:101:0)
[12:38:42.279] Timer tick, asking Buildbucket for the build status
[12:38:42.743] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:42.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:102:0) after 1m0s
[12:39:42.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:102:0)
[12:39:42.776] Timer tick, asking Buildbucket for the build status
[12:39:43.208] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:43.208] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:103:0) after 1m0s
[12:40:43.341] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:103:0)
[12:40:43.341] Timer tick, asking Buildbucket for the build status
[12:40:43.599] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:43.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:104:0) after 1m0s
[12:41:43.795] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:104:0)
[12:41:43.795] Timer tick, asking Buildbucket for the build status
[12:41:43.922] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:43.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:105:0) after 1m0s
[12:42:44.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:105:0)
[12:42:44.347] Timer tick, asking Buildbucket for the build status
[12:42:44.637] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:44.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:106:0) after 1m0s
[12:43:44.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:106:0)
[12:43:44.800] Timer tick, asking Buildbucket for the build status
[12:43:44.952] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:44.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:107:0) after 1m0s
[12:44:45.126] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:107:0)
[12:44:45.126] Timer tick, asking Buildbucket for the build status
[12:44:45.274] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:45.274] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:108:0) after 1m0s
[12:45:45.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:108:0)
[12:45:45.307] Timer tick, asking Buildbucket for the build status
[12:45:45.462] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:45.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:109:0) after 1m0s
[12:46:45.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:109:0)
[12:46:45.554] Timer tick, asking Buildbucket for the build status
[12:46:47.299] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:47.299] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:110:0) after 1m0s
[12:47:49.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:110:0)
[12:47:49.365] Timer tick, asking Buildbucket for the build status
[12:47:49.495] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:49.495] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:111:0) after 1m0s
[12:48:49.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:111:0)
[12:48:49.921] Timer tick, asking Buildbucket for the build status
[12:48:50.707] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:50.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:112:0) after 1m0s
[12:49:51.016] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:112:0)
[12:49:51.016] Timer tick, asking Buildbucket for the build status
[12:49:51.214] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:51.214] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:113:0) after 1m0s
[12:50:51.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:113:0)
[12:50:51.446] Timer tick, asking Buildbucket for the build status
[12:50:52.145] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:52.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:114:0) after 1m0s
[12:51:52.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:114:0)
[12:51:52.246] Timer tick, asking Buildbucket for the build status
[12:51:53.961] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:53.961] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:115:0) after 1m0s
[12:52:54.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:115:0)
[12:52:54.003] Timer tick, asking Buildbucket for the build status
[12:52:54.670] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:54.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:116:0) after 1m0s
[12:53:54.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:116:0)
[12:53:54.702] Timer tick, asking Buildbucket for the build status
[12:53:54.968] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:54.968] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:117:0) after 1m0s
[12:54:54.969] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:117:0)
[12:54:54.969] Timer tick, asking Buildbucket for the build status
[12:54:55.932] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:55.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:118:0) after 1m0s
[12:55:55.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:118:0)
[12:55:55.956] Timer tick, asking Buildbucket for the build status
[12:55:56.084] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:56.084] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:119:0) after 1m0s
[12:56:56.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:119:0)
[12:56:56.156] Timer tick, asking Buildbucket for the build status
[12:56:56.371] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:56.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:120:0) after 1m0s
[12:57:56.407] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:120:0)
[12:57:56.407] Timer tick, asking Buildbucket for the build status
[12:57:56.591] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:56.591] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:121:0) after 1m0s
[12:58:56.666] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:121:0)
[12:58:56.666] Timer tick, asking Buildbucket for the build status
[12:58:58.317] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:122:0) after 1m0s
[12:59:58.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:122:0)
[12:59:58.451] Timer tick, asking Buildbucket for the build status
[12:59:58.648] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:58.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:123:0) after 1m0s
[13:00:58.785] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:123:0)
[13:00:58.785] Timer tick, asking Buildbucket for the build status
[13:00:59.067] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:59.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:124:0) after 1m0s
[13:01:59.279] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:124:0)
[13:01:59.279] Timer tick, asking Buildbucket for the build status
[13:01:59.539] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:59.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:125:0) after 1m0s
[13:02:59.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:125:0)
[13:02:59.758] Timer tick, asking Buildbucket for the build status
[13:02:59.869] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:59.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:126:0) after 1m0s
[13:04:00.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:126:0)
[13:04:00.054] Timer tick, asking Buildbucket for the build status
[13:04:00.334] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:00.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:127:0) after 1m0s
[13:05:00.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:127:0)
[13:05:00.477] Timer tick, asking Buildbucket for the build status
[13:05:00.677] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:00.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:128:0) after 1m0s
[13:06:03.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:128:0)
[13:06:03.587] Timer tick, asking Buildbucket for the build status
[13:06:03.800] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:03.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:129:0) after 1m0s
[13:07:03.898] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:129:0)
[13:07:03.898] Timer tick, asking Buildbucket for the build status
[13:07:04.438] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:130:0) after 1m0s
[13:08:04.513] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:130:0)
[13:08:04.513] Timer tick, asking Buildbucket for the build status
[13:08:06.663] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:06.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:131:0) after 1m0s
[13:09:06.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:131:0)
[13:09:06.775] Timer tick, asking Buildbucket for the build status
[13:09:08.417] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:08.417] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:132:0) after 1m0s
[13:10:08.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:132:0)
[13:10:08.450] Timer tick, asking Buildbucket for the build status
[13:10:08.963] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:08.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:133:0) after 1m0s
[13:11:09.025] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:133:0)
[13:11:09.025] Timer tick, asking Buildbucket for the build status
[13:11:09.493] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:09.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:134:0) after 1m0s
[13:12:09.541] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:134:0)
[13:12:09.541] Timer tick, asking Buildbucket for the build status
[13:12:09.682] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:09.682] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:135:0) after 1m0s
[13:13:09.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:135:0)
[13:13:09.746] Timer tick, asking Buildbucket for the build status
[13:13:10.032] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:10.032] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:136:0) after 1m0s
[13:14:10.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:136:0)
[13:14:10.073] Timer tick, asking Buildbucket for the build status
[13:14:11.992] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:11.992] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:137:0) after 1m0s
[13:15:12.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:137:0)
[13:15:12.128] Timer tick, asking Buildbucket for the build status
[13:15:12.280] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:12.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:138:0) after 1m0s
[13:16:12.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:138:0)
[13:16:12.318] Timer tick, asking Buildbucket for the build status
[13:16:13.616] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:13.616] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:139:0) after 1m0s
[13:17:13.647] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:139:0)
[13:17:13.647] Timer tick, asking Buildbucket for the build status
[13:17:14.145] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:14.145] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:140:0) after 1m0s
[13:18:14.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:140:0)
[13:18:14.249] Timer tick, asking Buildbucket for the build status
[13:18:15.019] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:15.019] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:141:0) after 1m0s
[13:19:15.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:141:0)
[13:19:15.045] Timer tick, asking Buildbucket for the build status
[13:19:15.394] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:15.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:142:0) after 1m0s
[13:20:15.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:142:0)
[13:20:15.524] Timer tick, asking Buildbucket for the build status
[13:20:16.428] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:16.428] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:143:0) after 1m0s
[13:21:16.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:143:0)
[13:21:16.459] Timer tick, asking Buildbucket for the build status
[13:21:17.413] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:17.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:144:0) after 1m0s
[13:22:17.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:144:0)
[13:22:17.459] Timer tick, asking Buildbucket for the build status
[13:22:17.648] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:17.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:145:0) after 1m0s
[13:23:17.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:145:0)
[13:23:17.686] Timer tick, asking Buildbucket for the build status
[13:23:20.013] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:20.013] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:146:0) after 1m0s
[13:24:20.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:146:0)
[13:24:20.047] Timer tick, asking Buildbucket for the build status
[13:24:20.219] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:20.219] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:147:0) after 1m0s
[13:25:20.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:147:0)
[13:25:20.264] Timer tick, asking Buildbucket for the build status
[13:25:20.946] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:148:0) after 1m0s
[13:26:20.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:148:0)
[13:26:20.979] Timer tick, asking Buildbucket for the build status
[13:26:21.186] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:21.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:149:0) after 1m0s
[13:27:21.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:149:0)
[13:27:21.284] Timer tick, asking Buildbucket for the build status
[13:27:21.552] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:21.552] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:150:0) after 1m0s
[13:28:21.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:150:0)
[13:28:21.633] Timer tick, asking Buildbucket for the build status
[13:28:21.861] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:21.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:151:0) after 1m0s
[13:29:21.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:151:0)
[13:29:21.897] Timer tick, asking Buildbucket for the build status
[13:29:22.153] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:22.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:152:0) after 1m0s
[13:30:22.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:152:0)
[13:30:22.210] Timer tick, asking Buildbucket for the build status
[13:30:22.721] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:22.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:153:0) after 1m0s
[13:31:23.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:153:0)
[13:31:23.039] Timer tick, asking Buildbucket for the build status
[13:31:23.241] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:23.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:154:0) after 1m0s
[13:32:23.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:154:0)
[13:32:23.350] Timer tick, asking Buildbucket for the build status
[13:32:26.107] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:26.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:155:0) after 1m0s
[13:33:26.108] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:155:0)
[13:33:26.108] Timer tick, asking Buildbucket for the build status
[13:33:26.463] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:26.463] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:156:0) after 1m0s
[13:34:26.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:156:0)
[13:34:26.750] Timer tick, asking Buildbucket for the build status
[13:34:27.844] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:27.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:157:0) after 1m0s
[13:35:28.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:157:0)
[13:35:28.285] Timer tick, asking Buildbucket for the build status
[13:35:28.722] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:28.722] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:158:0) after 1m0s
[13:36:28.837] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:158:0)
[13:36:28.837] Timer tick, asking Buildbucket for the build status
[13:36:29.514] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:29.514] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:159:0) after 1m0s
[13:37:29.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:159:0)
[13:37:29.525] Timer tick, asking Buildbucket for the build status
[13:37:29.859] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:29.859] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:160:0) after 1m0s
[13:38:29.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:160:0)
[13:38:29.910] Timer tick, asking Buildbucket for the build status
[13:38:30.900] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:30.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:161:0) after 1m0s
[13:39:30.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:161:0)
[13:39:30.964] Timer tick, asking Buildbucket for the build status
[13:39:32.809] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:32.809] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:162:0) after 1m0s
[13:40:32.859] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:162:0)
[13:40:32.859] Timer tick, asking Buildbucket for the build status
[13:40:34.994] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:34.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:163:0) after 1m0s
[13:41:35.113] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:163:0)
[13:41:35.113] Timer tick, asking Buildbucket for the build status
[13:41:35.252] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:35.252] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:164:0) after 1m0s
[13:42:35.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:164:0)
[13:42:35.390] Timer tick, asking Buildbucket for the build status
[13:42:40.515] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:40.515] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:165:0) after 1m0s
[13:43:40.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:165:0)
[13:43:40.568] Timer tick, asking Buildbucket for the build status
[13:43:40.761] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:40.761] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:166:0) after 1m0s
[13:44:40.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:166:0)
[13:44:40.813] Timer tick, asking Buildbucket for the build status
[13:44:41.004] Build 8905607058102855136: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:41.004] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9071037120939254944:167:0) after 1m0s
[13:45:17.204] Received PubSub notification, asking Buildbucket for the build status
[13:45:17.358] Build 8905607058102855136: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:45:17.358] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1565358315398479",
"created_by": "project:chromium",
"created_ts": "1565348298889520",
"id": "8905607058102855136",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"032c3bea76deafdebb369016a488367a093dbcaf\"}}",
"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-q2vi\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14374, \"got_angle_revision\": \"eb0479e245f0b6ba5bbe00ef7299ecaa82f8c6e1\", \"got_dawn_revision\": \"ebb05399c09af7814a21aa555800656b4f5021b2\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"032c3bea76deafdebb369016a488367a093dbcaf\", \"got_revision_cp\": \"refs/heads/master@{#685520}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"46afc4f9a6008c3880fcc00783b4210cb467aa9a\", \"got_v8_revision_cp\": \"refs/heads/7.8.71@{#1}\", \"got_webrtc_revision\": \"273e263d25b4ba2533c7f059dbf5ccd141dd0f7a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28816}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"032c3bea76deafdebb369016a488367a093dbcaf\"}, \"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-q2vi\"], \"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\": [\"4397-8786906\"], \"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": "1565348303155927",
"status": "COMPLETED",
"status_changed_ts": "1565358316548279",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14374",
"builder:Windows deterministic",
"buildset:commit/git/032c3bea76deafdebb369016a488367a093dbcaf",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/032c3bea76deafdebb369016a488367a093dbcaf",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9071037120939254944",
"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/8905607058102855136/+/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:468ed90fc07a8310",
"user_agent:luci-scheduler"
],
"updated_ts": "1565358316555301",
"url": "https://ci.chromium.org/b/8905607058102855136",
"utcnow_ts": "1565358317348630"
}
}
[13:45:17.358] Invocation finished in 2h47m0.55833474s with status SUCCEEDED