[00:23:57.699] New invocation is queued and will start shortly
[00:23:59.490] Starting the invocation (attempt 1)
[00:23:59.521] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:23:59.521] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:23:59.521] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9074791504439592544",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"8e75b51cbedcc14b0ad9313e54ca1f41b2284f81\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9074791504439592544",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"gitiles_ref:refs/heads/master"
]
}
[00:24:01.743] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1561767839757460",
"id": "8909361441617529344",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8e75b51cbedcc14b0ad9313e54ca1f41b2284f81\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1561767840705232",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13965",
"builder:Windows deterministic",
"buildset:commit/git/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074791504439592544",
"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/8909361441617529344/+/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": "1561767840705377",
"url": "https://ci.chromium.org/b/8909361441617529344",
"utcnow_ts": "1561767841725263"
}
}
[00:24:01.743] Task URL: https://ci.chromium.org/b/8909361441617529344
[00:24:01.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:2:0) after 1m0s
[00:24:06.216] Received PubSub notification, asking Buildbucket for the build status
[00:24:08.232] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:01.790] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:2:0)
[00:25:01.790] Timer tick, asking Buildbucket for the build status
[00:25:04.226] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:04.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:4:0) after 1m0s
[00:26:04.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:4:0)
[00:26:04.245] Timer tick, asking Buildbucket for the build status
[00:26:04.536] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:04.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:5:0) after 1m0s
[00:27:04.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:5:0)
[00:27:04.551] Timer tick, asking Buildbucket for the build status
[00:27:05.466] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:05.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:6:0) after 1m0s
[00:28:05.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:6:0)
[00:28:05.510] Timer tick, asking Buildbucket for the build status
[00:28:07.065] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:07.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:7:0) after 1m0s
[00:29:07.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:7:0)
[00:29:07.084] Timer tick, asking Buildbucket for the build status
[00:29:07.527] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:07.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:8:0) after 1m0s
[00:30:07.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:8:0)
[00:30:07.623] Timer tick, asking Buildbucket for the build status
[00:30:09.602] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:09.602] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:9:0) after 1m0s
[00:31:09.658] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:9:0)
[00:31:09.658] Timer tick, asking Buildbucket for the build status
[00:31:11.850] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:11.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:10:0) after 1m0s
[00:32:11.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:10:0)
[00:32:11.988] Timer tick, asking Buildbucket for the build status
[00:32:13.453] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:13.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:11:0) after 1m0s
[00:33:13.466] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:11:0)
[00:33:13.466] Timer tick, asking Buildbucket for the build status
[00:33:14.162] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:14.162] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:12:0) after 1m0s
[00:34:14.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:12:0)
[00:34:14.303] Timer tick, asking Buildbucket for the build status
[00:34:15.743] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:15.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:13:0) after 1m0s
[00:35:15.861] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:13:0)
[00:35:15.861] Timer tick, asking Buildbucket for the build status
[00:35:16.034] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:16.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:14:0) after 1m0s
[00:36:16.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:14:0)
[00:36:16.084] Timer tick, asking Buildbucket for the build status
[00:36:16.444] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:16.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:15:0) after 1m0s
[00:37:16.520] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:15:0)
[00:37:16.520] Timer tick, asking Buildbucket for the build status
[00:37:17.241] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:17.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:16:0) after 1m0s
[00:38:17.315] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:16:0)
[00:38:17.315] Timer tick, asking Buildbucket for the build status
[00:38:18.913] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:18.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:17:0) after 1m0s
[00:39:18.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:17:0)
[00:39:18.928] Timer tick, asking Buildbucket for the build status
[00:39:19.403] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:19.404] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:18:0) after 1m0s
[00:40:19.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:18:0)
[00:40:19.529] Timer tick, asking Buildbucket for the build status
[00:40:20.118] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:20.118] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:19:0) after 1m0s
[00:41:20.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:19:0)
[00:41:20.378] Timer tick, asking Buildbucket for the build status
[00:41:23.383] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:23.383] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:20:0) after 1m0s
[00:42:23.904] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:20:0)
[00:42:23.904] Timer tick, asking Buildbucket for the build status
[00:42:24.155] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:24.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:21:0) after 1m0s
[00:43:24.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:21:0)
[00:43:24.277] Timer tick, asking Buildbucket for the build status
[00:43:24.840] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:24.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:22:0) after 1m0s
[00:44:25.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:22:0)
[00:44:25.010] Timer tick, asking Buildbucket for the build status
[00:44:25.601] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:25.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:23:0) after 1m0s
[00:45:25.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:23:0)
[00:45:25.628] Timer tick, asking Buildbucket for the build status
[00:45:25.765] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:25.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:24:0) after 1m0s
[00:46:25.974] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:24:0)
[00:46:25.974] Timer tick, asking Buildbucket for the build status
[00:46:26.106] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:26.106] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:25:0) after 1m0s
[00:47:26.179] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:25:0)
[00:47:26.179] Timer tick, asking Buildbucket for the build status
[00:47:27.211] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:27.211] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:26:0) after 1m0s
[00:48:27.320] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:26:0)
[00:48:27.320] Timer tick, asking Buildbucket for the build status
[00:48:27.481] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:27.481] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:27:0) after 1m0s
[00:49:27.543] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:27:0)
[00:49:27.543] Timer tick, asking Buildbucket for the build status
[00:49:27.665] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:27.665] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:28:0) after 1m0s
[00:50:27.796] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:28:0)
[00:50:27.796] Timer tick, asking Buildbucket for the build status
[00:50:28.095] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:28.095] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:29:0) after 1m0s
[00:51:28.204] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:29:0)
[00:51:28.204] Timer tick, asking Buildbucket for the build status
[00:51:28.328] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:28.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:30:0) after 1m0s
[00:52:28.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:30:0)
[00:52:28.348] Timer tick, asking Buildbucket for the build status
[00:52:28.599] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:28.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:31:0) after 1m0s
[00:53:28.651] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:31:0)
[00:53:28.651] Timer tick, asking Buildbucket for the build status
[00:53:28.824] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:28.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:32:0) after 1m0s
[00:54:28.942] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:32:0)
[00:54:28.942] Timer tick, asking Buildbucket for the build status
[00:54:29.598] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:29.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:33:0) after 1m0s
[00:55:29.703] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:33:0)
[00:55:29.703] Timer tick, asking Buildbucket for the build status
[00:55:29.864] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:29.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:34:0) after 1m0s
[00:56:29.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:34:0)
[00:56:29.928] Timer tick, asking Buildbucket for the build status
[00:56:30.322] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:30.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:35:0) after 1m0s
[00:57:30.373] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:35:0)
[00:57:30.373] Timer tick, asking Buildbucket for the build status
[00:57:31.405] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:31.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:36:0) after 1m0s
[00:58:31.483] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:36:0)
[00:58:31.483] Timer tick, asking Buildbucket for the build status
[00:58:31.661] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:31.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:37:0) after 1m0s
[00:59:31.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:37:0)
[00:59:31.688] Timer tick, asking Buildbucket for the build status
[00:59:32.012] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:32.012] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:38:0) after 1m0s
[01:00:32.089] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:38:0)
[01:00:32.089] Timer tick, asking Buildbucket for the build status
[01:00:34.108] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:34.108] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:39:0) after 1m0s
[01:01:34.141] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:39:0)
[01:01:34.141] Timer tick, asking Buildbucket for the build status
[01:01:34.389] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:34.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:40:0) after 1m0s
[01:02:34.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:40:0)
[01:02:34.381] Timer tick, asking Buildbucket for the build status
[01:02:34.974] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:34.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:41:0) after 1m0s
[01:03:34.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:41:0)
[01:03:34.999] Timer tick, asking Buildbucket for the build status
[01:03:37.522] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:37.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:42:0) after 1m0s
[01:04:37.565] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:42:0)
[01:04:37.565] Timer tick, asking Buildbucket for the build status
[01:04:39.473] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:39.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:43:0) after 1m0s
[01:05:39.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:43:0)
[01:05:39.497] Timer tick, asking Buildbucket for the build status
[01:05:42.092] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:42.092] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:44:0) after 1m0s
[01:06:42.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:44:0)
[01:06:42.134] Timer tick, asking Buildbucket for the build status
[01:06:42.408] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:42.408] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:45:0) after 1m0s
[01:07:42.464] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:45:0)
[01:07:42.464] Timer tick, asking Buildbucket for the build status
[01:07:44.516] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:44.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:46:0) after 1m0s
[01:08:44.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:46:0)
[01:08:44.611] Timer tick, asking Buildbucket for the build status
[01:08:45.289] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:45.289] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:47:0) after 1m0s
[01:09:45.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:47:0)
[01:09:45.348] Timer tick, asking Buildbucket for the build status
[01:09:45.553] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:45.553] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:48:0) after 1m0s
[01:10:45.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:48:0)
[01:10:45.590] Timer tick, asking Buildbucket for the build status
[01:10:46.749] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:46.749] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:49:0) after 1m0s
[01:11:46.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:49:0)
[01:11:46.773] Timer tick, asking Buildbucket for the build status
[01:11:50.535] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:50.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:50:0) after 1m0s
[01:12:50.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:50:0)
[01:12:50.561] Timer tick, asking Buildbucket for the build status
[01:12:51.056] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:51.056] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:51:0) after 1m0s
[01:13:51.173] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:51:0)
[01:13:51.173] Timer tick, asking Buildbucket for the build status
[01:13:53.885] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:53.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:52:0) after 1m0s
[01:14:53.879] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:52:0)
[01:14:53.879] Timer tick, asking Buildbucket for the build status
[01:14:55.762] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:55.762] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:53:0) after 1m0s
[01:15:55.873] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:53:0)
[01:15:55.873] Timer tick, asking Buildbucket for the build status
[01:15:57.923] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:54:0) after 1m0s
[01:16:58.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:54:0)
[01:16:58.064] Timer tick, asking Buildbucket for the build status
[01:16:58.268] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:58.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:55:0) after 1m0s
[01:17:58.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:55:0)
[01:17:58.305] Timer tick, asking Buildbucket for the build status
[01:18:00.854] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:00.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:56:0) after 1m0s
[01:19:00.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:56:0)
[01:19:00.885] Timer tick, asking Buildbucket for the build status
[01:19:02.876] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:02.876] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:57:0) after 1m0s
[01:20:02.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:57:0)
[01:20:02.899] Timer tick, asking Buildbucket for the build status
[01:20:05.268] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:05.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:58:0) after 1m0s
[01:21:05.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:58:0)
[01:21:05.293] Timer tick, asking Buildbucket for the build status
[01:21:05.490] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:05.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:59:0) after 1m0s
[01:22:05.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:59:0)
[01:22:05.590] Timer tick, asking Buildbucket for the build status
[01:22:07.743] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:60:0) after 1m0s
[01:23:07.866] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:60:0)
[01:23:07.866] Timer tick, asking Buildbucket for the build status
[01:23:08.064] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:08.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:61:0) after 1m0s
[01:24:08.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:61:0)
[01:24:08.167] Timer tick, asking Buildbucket for the build status
[01:24:10.458] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:10.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:62:0) after 1m0s
[01:25:10.484] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:62:0)
[01:25:10.484] Timer tick, asking Buildbucket for the build status
[01:25:12.034] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:12.034] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:63:0) after 1m0s
[01:26:12.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:63:0)
[01:26:12.058] Timer tick, asking Buildbucket for the build status
[01:26:12.206] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:12.206] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:64:0) after 1m0s
[01:27:12.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:64:0)
[01:27:12.264] Timer tick, asking Buildbucket for the build status
[01:27:12.958] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:12.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:65:0) after 1m0s
[01:28:12.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:65:0)
[01:28:12.963] Timer tick, asking Buildbucket for the build status
[01:28:13.183] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:13.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:66:0) after 1m0s
[01:29:13.207] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:66:0)
[01:29:13.207] Timer tick, asking Buildbucket for the build status
[01:29:14.014] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:14.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:67:0) after 1m0s
[01:30:14.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:67:0)
[01:30:14.182] Timer tick, asking Buildbucket for the build status
[01:30:15.972] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:15.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:68:0) after 1m0s
[01:31:16.058] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:68:0)
[01:31:16.058] Timer tick, asking Buildbucket for the build status
[01:31:18.699] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:18.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:69:0) after 1m0s
[01:32:18.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:69:0)
[01:32:18.744] Timer tick, asking Buildbucket for the build status
[01:32:20.681] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:20.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:70:0) after 1m0s
[01:33:20.739] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:70:0)
[01:33:20.739] Timer tick, asking Buildbucket for the build status
[01:33:21.570] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:21.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:71:0) after 1m0s
[01:34:21.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:71:0)
[01:34:21.592] Timer tick, asking Buildbucket for the build status
[01:34:24.373] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:24.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:72:0) after 1m0s
[01:35:24.397] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:72:0)
[01:35:24.397] Timer tick, asking Buildbucket for the build status
[01:35:24.732] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:24.732] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:73:0) after 1m0s
[01:36:24.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:73:0)
[01:36:24.791] Timer tick, asking Buildbucket for the build status
[01:36:26.601] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:26.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:74:0) after 1m0s
[01:37:26.660] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:74:0)
[01:37:26.660] Timer tick, asking Buildbucket for the build status
[01:37:28.189] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:28.189] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:75:0) after 1m0s
[01:38:28.203] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:75:0)
[01:38:28.203] Timer tick, asking Buildbucket for the build status
[01:38:30.943] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:30.943] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:76:0) after 1m0s
[01:39:30.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:76:0)
[01:39:30.991] Timer tick, asking Buildbucket for the build status
[01:39:31.308] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:77:0) after 1m0s
[01:40:31.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:77:0)
[01:40:31.368] Timer tick, asking Buildbucket for the build status
[01:40:32.855] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:32.855] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:78:0) after 1m0s
[01:41:32.929] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:78:0)
[01:41:32.929] Timer tick, asking Buildbucket for the build status
[01:41:33.233] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:33.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:79:0) after 1m0s
[01:42:33.365] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:79:0)
[01:42:33.365] Timer tick, asking Buildbucket for the build status
[01:42:33.808] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:33.808] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:80:0) after 1m0s
[01:43:33.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:80:0)
[01:43:33.801] Timer tick, asking Buildbucket for the build status
[01:43:36.016] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:36.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:81:0) after 1m0s
[01:44:36.044] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:81:0)
[01:44:36.044] Timer tick, asking Buildbucket for the build status
[01:44:36.939] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:36.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:82:0) after 1m0s
[01:45:36.996] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:82:0)
[01:45:36.996] Timer tick, asking Buildbucket for the build status
[01:45:37.431] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:37.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:83:0) after 1m0s
[01:46:37.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:83:0)
[01:46:37.411] Timer tick, asking Buildbucket for the build status
[01:46:37.528] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:37.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:84:0) after 1m0s
[01:47:37.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:84:0)
[01:47:37.551] Timer tick, asking Buildbucket for the build status
[01:47:37.788] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:37.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:85:0) after 1m0s
[01:48:37.787] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:85:0)
[01:48:37.787] Timer tick, asking Buildbucket for the build status
[01:48:39.586] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:39.587] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:86:0) after 1m0s
[01:49:39.714] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:86:0)
[01:49:39.714] Timer tick, asking Buildbucket for the build status
[01:49:39.906] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:39.906] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:87:0) after 1m0s
[01:50:40.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:87:0)
[01:50:40.036] Timer tick, asking Buildbucket for the build status
[01:50:40.373] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:40.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:88:0) after 1m0s
[01:51:40.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:88:0)
[01:51:40.384] Timer tick, asking Buildbucket for the build status
[01:51:42.492] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:42.492] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:89:0) after 1m0s
[01:52:42.535] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:89:0)
[01:52:42.535] Timer tick, asking Buildbucket for the build status
[01:52:42.713] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:42.713] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:90:0) after 1m0s
[01:53:42.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:90:0)
[01:53:42.754] Timer tick, asking Buildbucket for the build status
[01:53:44.689] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:44.689] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:91:0) after 1m0s
[01:54:44.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:91:0)
[01:54:44.849] Timer tick, asking Buildbucket for the build status
[01:54:47.983] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:47.983] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:92:0) after 1m0s
[01:55:47.975] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:92:0)
[01:55:47.975] Timer tick, asking Buildbucket for the build status
[01:55:48.394] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:48.394] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:93:0) after 1m0s
[01:56:48.465] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:93:0)
[01:56:48.465] Timer tick, asking Buildbucket for the build status
[01:56:49.035] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:49.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:94:0) after 1m0s
[01:57:49.062] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:94:0)
[01:57:49.062] Timer tick, asking Buildbucket for the build status
[01:57:49.265] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:49.265] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:95:0) after 1m0s
[01:58:49.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:95:0)
[01:58:49.313] Timer tick, asking Buildbucket for the build status
[01:58:51.935] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:51.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:96:0) after 1m0s
[01:59:52.021] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:96:0)
[01:59:52.021] Timer tick, asking Buildbucket for the build status
[01:59:54.903] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:54.904] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:97:0) after 1m0s
[02:00:55.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:97:0)
[02:00:55.003] Timer tick, asking Buildbucket for the build status
[02:00:55.800] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:55.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:98:0) after 1m0s
[02:01:55.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:98:0)
[02:01:55.887] Timer tick, asking Buildbucket for the build status
[02:01:56.646] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:56.646] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:99:0) after 1m0s
[02:02:56.683] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:99:0)
[02:02:56.683] Timer tick, asking Buildbucket for the build status
[02:02:58.427] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:58.427] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:100:0) after 1m0s
[02:03:58.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:100:0)
[02:03:58.508] Timer tick, asking Buildbucket for the build status
[02:03:59.147] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:59.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:101:0) after 1m0s
[02:04:59.234] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:101:0)
[02:04:59.234] Timer tick, asking Buildbucket for the build status
[02:05:01.718] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:01.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:102:0) after 1m0s
[02:06:01.745] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:102:0)
[02:06:01.745] Timer tick, asking Buildbucket for the build status
[02:06:02.078] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:02.078] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:103:0) after 1m0s
[02:07:02.103] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:103:0)
[02:07:02.103] Timer tick, asking Buildbucket for the build status
[02:07:02.459] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:02.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:104:0) after 1m0s
[02:08:02.566] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:104:0)
[02:08:02.566] Timer tick, asking Buildbucket for the build status
[02:08:03.001] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:03.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:105:0) after 1m0s
[02:09:03.061] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:105:0)
[02:09:03.061] Timer tick, asking Buildbucket for the build status
[02:09:03.685] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:03.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:106:0) after 1m0s
[02:10:03.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:106:0)
[02:10:03.794] Timer tick, asking Buildbucket for the build status
[02:10:04.039] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:04.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:107:0) after 1m0s
[02:11:04.068] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:107:0)
[02:11:04.068] Timer tick, asking Buildbucket for the build status
[02:11:06.486] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:06.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:108:0) after 1m0s
[02:12:06.554] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:108:0)
[02:12:06.554] Timer tick, asking Buildbucket for the build status
[02:12:08.475] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:08.475] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:109:0) after 1m0s
[02:13:08.560] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:109:0)
[02:13:08.560] Timer tick, asking Buildbucket for the build status
[02:13:10.348] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:10.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:110:0) after 1m0s
[02:14:10.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:110:0)
[02:14:10.450] Timer tick, asking Buildbucket for the build status
[02:14:13.857] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:13.857] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:111:0) after 1m0s
[02:15:13.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:111:0)
[02:15:13.847] Timer tick, asking Buildbucket for the build status
[02:15:15.133] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:15.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:112:0) after 1m0s
[02:16:15.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:112:0)
[02:16:15.192] Timer tick, asking Buildbucket for the build status
[02:16:15.385] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:15.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:113:0) after 1m0s
[02:17:15.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:113:0)
[02:17:15.514] Timer tick, asking Buildbucket for the build status
[02:17:17.091] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:17.091] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:114:0) after 1m0s
[02:18:17.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:114:0)
[02:18:17.116] Timer tick, asking Buildbucket for the build status
[02:18:18.496] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:18.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:115:0) after 1m0s
[02:19:18.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:115:0)
[02:19:18.523] Timer tick, asking Buildbucket for the build status
[02:19:19.574] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:19.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:116:0) after 1m0s
[02:20:19.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:116:0)
[02:20:19.664] Timer tick, asking Buildbucket for the build status
[02:20:21.589] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:21.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:117:0) after 1m0s
[02:21:21.610] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:117:0)
[02:21:21.610] Timer tick, asking Buildbucket for the build status
[02:21:22.872] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:22.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:118:0) after 1m0s
[02:22:22.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:118:0)
[02:22:22.916] Timer tick, asking Buildbucket for the build status
[02:22:23.055] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:23.055] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:119:0) after 1m0s
[02:23:23.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:119:0)
[02:23:23.164] Timer tick, asking Buildbucket for the build status
[02:23:26.613] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:26.613] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:120:0) after 1m0s
[02:24:26.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:120:0)
[02:24:26.642] Timer tick, asking Buildbucket for the build status
[02:24:26.905] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:26.905] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:121:0) after 1m0s
[02:25:26.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:121:0)
[02:25:26.938] Timer tick, asking Buildbucket for the build status
[02:25:27.222] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:27.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:122:0) after 1m0s
[02:26:27.405] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:122:0)
[02:26:27.405] Timer tick, asking Buildbucket for the build status
[02:26:27.521] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:27.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:123:0) after 1m0s
[02:27:27.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:123:0)
[02:27:27.626] Timer tick, asking Buildbucket for the build status
[02:27:27.745] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:27.745] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:124:0) after 1m0s
[02:28:27.853] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:124:0)
[02:28:27.853] Timer tick, asking Buildbucket for the build status
[02:28:29.416] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:29.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:125:0) after 1m0s
[02:29:29.479] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:125:0)
[02:29:29.479] Timer tick, asking Buildbucket for the build status
[02:29:29.695] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:29.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:126:0) after 1m0s
[02:30:29.688] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:126:0)
[02:30:29.688] Timer tick, asking Buildbucket for the build status
[02:30:30.052] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:30.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:127:0) after 1m0s
[02:31:30.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:127:0)
[02:31:30.078] Timer tick, asking Buildbucket for the build status
[02:31:30.847] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:30.847] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:128:0) after 1m0s
[02:32:30.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:128:0)
[02:32:30.938] Timer tick, asking Buildbucket for the build status
[02:32:31.077] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:31.077] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:129:0) after 1m0s
[02:33:31.131] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:129:0)
[02:33:31.131] Timer tick, asking Buildbucket for the build status
[02:33:31.909] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:31.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:130:0) after 1m0s
[02:34:31.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:130:0)
[02:34:31.935] Timer tick, asking Buildbucket for the build status
[02:34:35.151] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:35.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:131:0) after 1m0s
[02:35:35.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:131:0)
[02:35:35.276] Timer tick, asking Buildbucket for the build status
[02:35:35.509] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:35.509] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:132:0) after 1m0s
[02:36:35.495] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:132:0)
[02:36:35.495] Timer tick, asking Buildbucket for the build status
[02:36:37.744] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:37.744] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:133:0) after 1m0s
[02:37:37.780] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:133:0)
[02:37:37.780] Timer tick, asking Buildbucket for the build status
[02:37:39.674] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:39.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:134:0) after 1m0s
[02:38:39.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:134:0)
[02:38:39.704] Timer tick, asking Buildbucket for the build status
[02:38:40.603] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.603] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:135:0) after 1m0s
[02:39:40.657] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:135:0)
[02:39:40.657] Timer tick, asking Buildbucket for the build status
[02:39:40.854] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:40.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:136:0) after 1m0s
[02:40:40.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:136:0)
[02:40:40.945] Timer tick, asking Buildbucket for the build status
[02:40:41.465] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:137:0) after 1m0s
[02:41:41.518] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:137:0)
[02:41:41.518] Timer tick, asking Buildbucket for the build status
[02:41:41.746] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.746] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:138:0) after 1m0s
[02:42:41.776] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:138:0)
[02:42:41.776] Timer tick, asking Buildbucket for the build status
[02:42:42.104] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:42.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:139:0) after 1m0s
[02:43:42.134] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:139:0)
[02:43:42.134] Timer tick, asking Buildbucket for the build status
[02:43:43.052] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:140:0) after 1m0s
[02:44:43.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:140:0)
[02:44:43.092] Timer tick, asking Buildbucket for the build status
[02:44:44.601] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:44.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:141:0) after 1m0s
[02:45:45.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:141:0)
[02:45:45.074] Timer tick, asking Buildbucket for the build status
[02:45:45.734] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:45.735] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:142:0) after 1m0s
[02:46:45.750] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:142:0)
[02:46:45.750] Timer tick, asking Buildbucket for the build status
[02:46:46.903] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:46.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:143:0) after 1m0s
[02:47:46.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:143:0)
[02:47:46.999] Timer tick, asking Buildbucket for the build status
[02:47:49.846] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:49.846] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:144:0) after 1m0s
[02:48:49.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:144:0)
[02:48:49.921] Timer tick, asking Buildbucket for the build status
[02:48:50.583] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:50.583] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:145:0) after 1m0s
[02:49:50.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:145:0)
[02:49:50.654] Timer tick, asking Buildbucket for the build status
[02:49:52.100] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:52.101] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:146:0) after 1m0s
[02:50:52.125] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:146:0)
[02:50:52.125] Timer tick, asking Buildbucket for the build status
[02:50:52.434] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:52.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:147:0) after 1m0s
[02:51:52.447] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:147:0)
[02:51:52.447] Timer tick, asking Buildbucket for the build status
[02:51:53.103] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:53.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:148:0) after 1m0s
[02:52:53.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:148:0)
[02:52:53.196] Timer tick, asking Buildbucket for the build status
[02:52:53.557] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:53.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:149:0) after 1m0s
[02:53:53.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:149:0)
[02:53:53.585] Timer tick, asking Buildbucket for the build status
[02:53:54.541] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:54.541] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:150:0) after 1m0s
[02:54:54.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:150:0)
[02:54:54.563] Timer tick, asking Buildbucket for the build status
[02:54:54.882] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:54.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:151:0) after 1m0s
[02:55:54.925] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:151:0)
[02:55:54.925] Timer tick, asking Buildbucket for the build status
[02:55:55.360] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:55.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:152:0) after 1m0s
[02:56:55.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:152:0)
[02:56:55.454] Timer tick, asking Buildbucket for the build status
[02:56:56.187] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:56.187] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:153:0) after 1m0s
[02:57:56.186] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:153:0)
[02:57:56.186] Timer tick, asking Buildbucket for the build status
[02:57:56.771] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:56.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:154:0) after 1m0s
[02:58:56.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:154:0)
[02:58:56.755] Timer tick, asking Buildbucket for the build status
[02:58:57.231] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:57.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:155:0) after 1m0s
[02:59:57.246] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:155:0)
[02:59:57.246] Timer tick, asking Buildbucket for the build status
[02:59:57.561] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:57.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:156:0) after 1m0s
[03:00:57.593] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:156:0)
[03:00:57.593] Timer tick, asking Buildbucket for the build status
[03:00:58.018] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:58.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:157:0) after 1m0s
[03:01:58.037] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:157:0)
[03:01:58.037] Timer tick, asking Buildbucket for the build status
[03:01:58.493] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:58.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:158:0) after 1m0s
[03:02:58.555] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:158:0)
[03:02:58.555] Timer tick, asking Buildbucket for the build status
[03:02:59.637] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:59.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:159:0) after 1m0s
[03:03:59.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:159:0)
[03:03:59.722] Timer tick, asking Buildbucket for the build status
[03:04:00.839] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:00.839] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:160:0) after 1m0s
[03:05:01.074] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:160:0)
[03:05:01.074] Timer tick, asking Buildbucket for the build status
[03:05:02.294] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:02.294] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:161:0) after 1m0s
[03:06:02.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:161:0)
[03:06:02.475] Timer tick, asking Buildbucket for the build status
[03:06:02.649] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:02.649] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:162:0) after 1m0s
[03:07:02.747] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:162:0)
[03:07:02.747] Timer tick, asking Buildbucket for the build status
[03:07:02.868] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:02.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:163:0) after 1m0s
[03:08:02.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:163:0)
[03:08:02.897] Timer tick, asking Buildbucket for the build status
[03:08:03.057] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:03.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:164:0) after 1m0s
[03:09:03.156] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:164:0)
[03:09:03.156] Timer tick, asking Buildbucket for the build status
[03:09:03.584] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:03.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:165:0) after 1m0s
[03:10:03.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:165:0)
[03:10:03.695] Timer tick, asking Buildbucket for the build status
[03:10:04.522] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:04.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:166:0) after 1m0s
[03:11:04.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:166:0)
[03:11:04.777] Timer tick, asking Buildbucket for the build status
[03:11:05.117] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:167:0) after 1m0s
[03:12:05.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:167:0)
[03:12:05.258] Timer tick, asking Buildbucket for the build status
[03:12:05.915] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:05.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:168:0) after 1m0s
[03:13:06.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:168:0)
[03:13:06.059] Timer tick, asking Buildbucket for the build status
[03:13:06.660] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:06.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:169:0) after 1m0s
[03:14:06.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:169:0)
[03:14:06.811] Timer tick, asking Buildbucket for the build status
[03:14:07.035] Build 8909361441617529344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:07.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9074791504439592544:170:0) after 1m0s
[03:14:09.225] Received PubSub notification, asking Buildbucket for the build status
[03:14:09.428] Build 8909361441617529344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:14:09.428] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1561778048378654",
"created_by": "project:chromium",
"created_ts": "1561767839757460",
"id": "8909361441617529344",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8e75b51cbedcc14b0ad9313e54ca1f41b2284f81\"}}",
"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-4mnd\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 13965, \"got_angle_revision\": \"77c8496b5fd063e70d08a43ca6c994d2d7e7dc66\", \"got_dawn_revision\": \"eee3e41c554257a0ece66e70b2b4e1390ffa6ab0\", \"got_nacl_revision\": \"c4cf6f0621b94cca4053b19fa01ef329f5663880\", \"got_revision\": \"8e75b51cbedcc14b0ad9313e54ca1f41b2284f81\", \"got_revision_cp\": \"refs/heads/master@{#673552}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"45ddaacef4d3cd90c58d766380fc1f418f998cd2\", \"got_v8_revision_cp\": \"refs/heads/7.7.166@{#1}\", \"got_webrtc_revision\": \"67daf71689c33a50318746e5579055ec29621f59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28420}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"8e75b51cbedcc14b0ad9313e54ca1f41b2284f81\"}, \"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-4mnd\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"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\": [\"4351-b85b41c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1561767845357373",
"status": "COMPLETED",
"status_changed_ts": "1561778048732115",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13965",
"builder:Windows deterministic",
"buildset:commit/git/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e75b51cbedcc14b0ad9313e54ca1f41b2284f81",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9074791504439592544",
"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/8909361441617529344/+/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:45b96f9a269e2310",
"user_agent:luci-scheduler"
],
"updated_ts": "1561778048735554",
"url": "https://ci.chromium.org/b/8909361441617529344",
"utcnow_ts": "1561778049408256"
}
}
[03:14:09.428] Invocation finished in 2h50m11.745971282s with status SUCCEEDED