[02:08:40.319] New invocation is queued and will start shortly
[02:08:41.674] Starting the invocation (attempt 1)
[02:08:41.716] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:08:41.716] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:08:41.716] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9060470595942973168",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"4c7b231946f34fdcac75a7d0ba773c826f1f151e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9060470595942973168",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"gitiles_ref:refs/heads/master"
]
}
[02:08:43.891] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1575425322687746",
"id": "8895040532796621264",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c7b231946f34fdcac75a7d0ba773c826f1f151e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1575425323609273",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15373",
"builder:Windows deterministic",
"buildset:commit/git/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060470595942973168",
"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/8895040532796621264/+/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": "1575425323609405",
"url": "https://ci.chromium.org/b/8895040532796621264",
"utcnow_ts": "1575425323875661"
}
}
[02:08:43.891] Task URL: https://ci.chromium.org/b/8895040532796621264
[02:08:43.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:2:0) after 1m0s
[02:08:53.672] Received PubSub notification, asking Buildbucket for the build status
[02:08:53.817] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:43.917] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:2:0)
[02:09:43.917] Timer tick, asking Buildbucket for the build status
[02:09:44.152] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:44.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:4:0) after 1m0s
[02:10:44.210] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:4:0)
[02:10:44.210] Timer tick, asking Buildbucket for the build status
[02:10:44.377] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:44.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:5:0) after 1m0s
[02:11:44.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:5:0)
[02:11:44.406] Timer tick, asking Buildbucket for the build status
[02:11:45.143] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:45.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:6:0) after 1m0s
[02:12:45.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:6:0)
[02:12:45.168] Timer tick, asking Buildbucket for the build status
[02:12:46.269] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:46.269] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:7:0) after 1m0s
[02:13:46.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:7:0)
[02:13:46.299] Timer tick, asking Buildbucket for the build status
[02:13:46.521] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:46.521] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:8:0) after 1m0s
[02:14:46.536] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:8:0)
[02:14:46.536] Timer tick, asking Buildbucket for the build status
[02:14:47.453] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:47.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:9:0) after 1m0s
[02:15:47.528] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:9:0)
[02:15:47.528] Timer tick, asking Buildbucket for the build status
[02:15:47.770] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:47.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:10:0) after 1m0s
[02:16:47.956] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:10:0)
[02:16:47.956] Timer tick, asking Buildbucket for the build status
[02:16:48.152] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:48.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:11:0) after 1m0s
[02:17:48.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:11:0)
[02:17:48.162] Timer tick, asking Buildbucket for the build status
[02:17:49.025] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:49.025] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:12:0) after 1m0s
[02:18:49.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:12:0)
[02:18:49.128] Timer tick, asking Buildbucket for the build status
[02:18:49.390] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:49.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:13:0) after 1m0s
[02:19:49.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:13:0)
[02:19:49.550] Timer tick, asking Buildbucket for the build status
[02:19:49.858] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:49.858] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:14:0) after 1m0s
[02:20:49.916] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:14:0)
[02:20:49.916] Timer tick, asking Buildbucket for the build status
[02:20:50.530] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:50.530] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:15:0) after 1m0s
[02:21:50.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:15:0)
[02:21:50.639] Timer tick, asking Buildbucket for the build status
[02:21:50.950] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:50.950] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:16:0) after 1m0s
[02:22:51.015] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:16:0)
[02:22:51.015] Timer tick, asking Buildbucket for the build status
[02:22:51.915] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:51.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:17:0) after 1m0s
[02:23:52.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:17:0)
[02:23:52.008] Timer tick, asking Buildbucket for the build status
[02:23:52.185] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:52.185] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:18:0) after 1m0s
[02:24:52.318] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:18:0)
[02:24:52.318] Timer tick, asking Buildbucket for the build status
[02:24:53.490] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:53.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:19:0) after 1m0s
[02:25:53.511] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:19:0)
[02:25:53.511] Timer tick, asking Buildbucket for the build status
[02:25:53.727] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:53.727] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:20:0) after 1m0s
[02:26:53.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:20:0)
[02:26:53.751] Timer tick, asking Buildbucket for the build status
[02:26:54.459] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:54.459] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:21:0) after 1m0s
[02:27:54.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:21:0)
[02:27:54.508] Timer tick, asking Buildbucket for the build status
[02:27:56.696] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:56.696] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:22:0) after 1m0s
[02:28:56.718] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:22:0)
[02:28:56.718] Timer tick, asking Buildbucket for the build status
[02:28:56.987] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:56.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:23:0) after 1m0s
[02:29:57.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:23:0)
[02:29:57.183] Timer tick, asking Buildbucket for the build status
[02:29:58.024] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:58.024] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:24:0) after 1m0s
[02:30:58.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:24:0)
[02:30:58.067] Timer tick, asking Buildbucket for the build status
[02:30:58.765] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:58.765] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:25:0) after 1m0s
[02:31:58.862] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:25:0)
[02:31:58.862] Timer tick, asking Buildbucket for the build status
[02:31:59.280] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:59.280] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:26:0) after 1m0s
[02:32:59.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:26:0)
[02:32:59.340] Timer tick, asking Buildbucket for the build status
[02:33:00.888] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:00.888] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:27:0) after 1m0s
[02:34:00.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:27:0)
[02:34:00.966] Timer tick, asking Buildbucket for the build status
[02:34:01.164] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:01.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:28:0) after 1m0s
[02:35:01.269] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:28:0)
[02:35:01.269] Timer tick, asking Buildbucket for the build status
[02:35:01.967] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:01.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:29:0) after 1m0s
[02:36:02.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:29:0)
[02:36:02.102] Timer tick, asking Buildbucket for the build status
[02:36:02.484] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:02.484] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:30:0) after 1m0s
[02:37:02.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:30:0)
[02:37:02.693] Timer tick, asking Buildbucket for the build status
[02:37:02.891] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:02.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:31:0) after 1m0s
[02:38:03.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:31:0)
[02:38:03.012] Timer tick, asking Buildbucket for the build status
[02:38:03.200] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:03.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:32:0) after 1m0s
[02:39:03.378] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:32:0)
[02:39:03.378] Timer tick, asking Buildbucket for the build status
[02:39:03.661] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:03.661] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:33:0) after 1m0s
[02:40:03.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:33:0)
[02:40:03.758] Timer tick, asking Buildbucket for the build status
[02:40:03.903] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:03.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:34:0) after 1m0s
[02:41:04.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:34:0)
[02:41:04.042] Timer tick, asking Buildbucket for the build status
[02:41:04.312] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:04.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:35:0) after 1m0s
[02:42:04.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:35:0)
[02:42:04.380] Timer tick, asking Buildbucket for the build status
[02:42:04.623] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:04.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:36:0) after 1m0s
[02:43:04.650] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:36:0)
[02:43:04.650] Timer tick, asking Buildbucket for the build status
[02:43:04.910] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:04.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:37:0) after 1m0s
[02:44:04.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:37:0)
[02:44:04.951] Timer tick, asking Buildbucket for the build status
[02:44:06.599] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:06.599] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:38:0) after 1m0s
[02:45:06.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:38:0)
[02:45:06.633] Timer tick, asking Buildbucket for the build status
[02:45:06.920] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:06.920] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:39:0) after 1m0s
[02:46:06.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:39:0)
[02:46:06.906] Timer tick, asking Buildbucket for the build status
[02:46:07.510] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:07.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:40:0) after 1m0s
[02:47:07.584] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:40:0)
[02:47:07.584] Timer tick, asking Buildbucket for the build status
[02:47:08.466] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:08.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:41:0) after 1m0s
[02:48:08.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:41:0)
[02:48:08.553] Timer tick, asking Buildbucket for the build status
[02:48:09.261] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:09.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:42:0) after 1m0s
[02:49:09.306] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:42:0)
[02:49:09.306] Timer tick, asking Buildbucket for the build status
[02:49:09.508] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:09.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:43:0) after 1m0s
[02:50:09.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:43:0)
[02:50:09.583] Timer tick, asking Buildbucket for the build status
[02:50:09.798] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:09.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:44:0) after 1m0s
[02:51:09.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:44:0)
[02:51:09.887] Timer tick, asking Buildbucket for the build status
[02:51:10.086] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:10.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:45:0) after 1m0s
[02:52:10.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:45:0)
[02:52:10.372] Timer tick, asking Buildbucket for the build status
[02:52:11.027] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:11.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:46:0) after 1m0s
[02:53:11.371] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:46:0)
[02:53:11.371] Timer tick, asking Buildbucket for the build status
[02:53:12.255] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:12.255] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:47:0) after 1m0s
[02:54:12.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:47:0)
[02:54:12.338] Timer tick, asking Buildbucket for the build status
[02:54:12.629] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:12.629] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:48:0) after 1m0s
[02:55:12.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:48:0)
[02:55:12.812] Timer tick, asking Buildbucket for the build status
[02:55:13.011] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:13.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:49:0) after 1m0s
[02:56:13.042] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:49:0)
[02:56:13.042] Timer tick, asking Buildbucket for the build status
[02:56:13.760] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:13.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:50:0) after 1m0s
[02:57:13.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:50:0)
[02:57:13.868] Timer tick, asking Buildbucket for the build status
[02:57:14.057] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:51:0) after 1m0s
[02:58:14.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:51:0)
[02:58:14.190] Timer tick, asking Buildbucket for the build status
[02:58:14.384] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:14.384] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:52:0) after 1m0s
[02:59:14.469] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:52:0)
[02:59:14.469] Timer tick, asking Buildbucket for the build status
[02:59:14.726] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:14.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:53:0) after 1m0s
[03:00:14.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:53:0)
[03:00:14.842] Timer tick, asking Buildbucket for the build status
[03:00:15.301] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:15.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:54:0) after 1m0s
[03:01:15.339] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:54:0)
[03:01:15.339] Timer tick, asking Buildbucket for the build status
[03:01:15.667] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:15.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:55:0) after 1m0s
[03:02:15.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:55:0)
[03:02:15.910] Timer tick, asking Buildbucket for the build status
[03:02:16.196] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:16.196] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:56:0) after 1m0s
[03:03:16.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:56:0)
[03:03:16.344] Timer tick, asking Buildbucket for the build status
[03:03:17.868] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:17.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:57:0) after 1m0s
[03:04:18.136] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:57:0)
[03:04:18.136] Timer tick, asking Buildbucket for the build status
[03:04:18.371] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:18.371] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:58:0) after 1m0s
[03:05:18.408] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:58:0)
[03:05:18.408] Timer tick, asking Buildbucket for the build status
[03:05:18.633] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:18.633] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:59:0) after 1m0s
[03:06:18.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:59:0)
[03:06:18.669] Timer tick, asking Buildbucket for the build status
[03:06:18.860] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:18.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:60:0) after 1m0s
[03:07:18.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:60:0)
[03:07:18.968] Timer tick, asking Buildbucket for the build status
[03:07:20.028] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:20.028] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:61:0) after 1m0s
[03:08:20.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:61:0)
[03:08:20.297] Timer tick, asking Buildbucket for the build status
[03:08:20.472] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:20.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:62:0) after 1m0s
[03:09:20.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:62:0)
[03:09:20.807] Timer tick, asking Buildbucket for the build status
[03:09:21.052] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:21.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:63:0) after 1m0s
[03:10:21.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:63:0)
[03:10:21.084] Timer tick, asking Buildbucket for the build status
[03:10:21.253] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:21.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:64:0) after 1m0s
[03:11:21.594] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:64:0)
[03:11:21.594] Timer tick, asking Buildbucket for the build status
[03:11:21.928] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:21.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:65:0) after 1m0s
[03:12:22.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:65:0)
[03:12:22.064] Timer tick, asking Buildbucket for the build status
[03:12:22.234] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:22.234] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:66:0) after 1m0s
[03:13:22.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:66:0)
[03:13:22.245] Timer tick, asking Buildbucket for the build status
[03:13:22.823] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:22.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:67:0) after 1m0s
[03:14:22.884] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:67:0)
[03:14:22.884] Timer tick, asking Buildbucket for the build status
[03:14:23.349] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:68:0) after 1m0s
[03:15:23.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:68:0)
[03:15:23.411] Timer tick, asking Buildbucket for the build status
[03:15:24.639] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:24.639] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:69:0) after 1m0s
[03:16:24.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:69:0)
[03:16:24.851] Timer tick, asking Buildbucket for the build status
[03:16:25.365] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:25.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:70:0) after 1m0s
[03:17:25.383] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:70:0)
[03:17:25.383] Timer tick, asking Buildbucket for the build status
[03:17:25.834] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:71:0) after 1m0s
[03:18:25.976] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:71:0)
[03:18:25.976] Timer tick, asking Buildbucket for the build status
[03:18:26.254] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:26.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:72:0) after 1m0s
[03:19:26.321] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:72:0)
[03:19:26.321] Timer tick, asking Buildbucket for the build status
[03:19:26.506] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:26.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:73:0) after 1m0s
[03:20:26.613] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:73:0)
[03:20:26.613] Timer tick, asking Buildbucket for the build status
[03:20:27.094] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:27.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:74:0) after 1m0s
[03:21:27.196] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:74:0)
[03:21:27.196] Timer tick, asking Buildbucket for the build status
[03:21:27.370] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:27.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:75:0) after 1m0s
[03:22:27.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:75:0)
[03:22:27.358] Timer tick, asking Buildbucket for the build status
[03:22:27.575] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:27.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:76:0) after 1m0s
[03:23:27.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:76:0)
[03:23:27.633] Timer tick, asking Buildbucket for the build status
[03:23:28.051] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:28.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:77:0) after 1m0s
[03:24:28.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:77:0)
[03:24:28.085] Timer tick, asking Buildbucket for the build status
[03:24:28.278] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:28.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:78:0) after 1m0s
[03:25:28.309] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:78:0)
[03:25:28.309] Timer tick, asking Buildbucket for the build status
[03:25:28.510] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:28.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:79:0) after 1m0s
[03:26:28.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:79:0)
[03:26:28.568] Timer tick, asking Buildbucket for the build status
[03:26:28.867] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:28.867] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:80:0) after 1m0s
[03:27:28.911] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:80:0)
[03:27:28.911] Timer tick, asking Buildbucket for the build status
[03:27:29.149] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:29.149] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:81:0) after 1m0s
[03:28:29.217] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:81:0)
[03:28:29.217] Timer tick, asking Buildbucket for the build status
[03:28:29.754] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:29.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:82:0) after 1m0s
[03:29:29.794] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:82:0)
[03:29:29.794] Timer tick, asking Buildbucket for the build status
[03:29:30.368] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:30.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:83:0) after 1m0s
[03:30:30.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:83:0)
[03:30:30.400] Timer tick, asking Buildbucket for the build status
[03:30:30.567] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:30.567] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:84:0) after 1m0s
[03:31:30.611] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:84:0)
[03:31:30.611] Timer tick, asking Buildbucket for the build status
[03:31:30.750] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:30.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:85:0) after 1m0s
[03:32:31.004] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:85:0)
[03:32:31.004] Timer tick, asking Buildbucket for the build status
[03:32:31.575] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:31.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:86:0) after 1m0s
[03:33:31.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:86:0)
[03:33:31.592] Timer tick, asking Buildbucket for the build status
[03:33:32.001] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:32.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:87:0) after 1m0s
[03:34:32.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:87:0)
[03:34:32.149] Timer tick, asking Buildbucket for the build status
[03:34:32.418] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:32.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:88:0) after 1m0s
[03:35:32.553] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:88:0)
[03:35:32.553] Timer tick, asking Buildbucket for the build status
[03:35:32.771] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:32.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:89:0) after 1m0s
[03:36:32.920] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:89:0)
[03:36:32.920] Timer tick, asking Buildbucket for the build status
[03:36:33.519] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:33.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:90:0) after 1m0s
[03:37:33.686] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:90:0)
[03:37:33.686] Timer tick, asking Buildbucket for the build status
[03:37:35.786] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:35.786] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:91:0) after 1m0s
[03:38:36.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:91:0)
[03:38:36.185] Timer tick, asking Buildbucket for the build status
[03:38:36.934] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:36.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:92:0) after 1m0s
[03:39:36.972] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:92:0)
[03:39:36.972] Timer tick, asking Buildbucket for the build status
[03:39:37.797] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:37.797] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:93:0) after 1m0s
[03:40:37.852] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:93:0)
[03:40:37.852] Timer tick, asking Buildbucket for the build status
[03:40:38.029] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:38.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:94:0) after 1m0s
[03:41:38.083] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:94:0)
[03:41:38.083] Timer tick, asking Buildbucket for the build status
[03:41:38.302] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:95:0) after 1m0s
[03:42:38.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:95:0)
[03:42:38.621] Timer tick, asking Buildbucket for the build status
[03:42:39.015] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:39.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:96:0) after 1m0s
[03:43:39.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:96:0)
[03:43:39.079] Timer tick, asking Buildbucket for the build status
[03:43:39.267] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:39.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:97:0) after 1m0s
[03:44:39.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:97:0)
[03:44:39.401] Timer tick, asking Buildbucket for the build status
[03:44:39.539] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:39.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:98:0) after 1m0s
[03:45:39.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:98:0)
[03:45:39.701] Timer tick, asking Buildbucket for the build status
[03:45:40.193] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:40.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:99:0) after 1m0s
[03:46:40.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:99:0)
[03:46:40.334] Timer tick, asking Buildbucket for the build status
[03:46:40.869] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:40.869] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:100:0) after 1m0s
[03:47:40.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:100:0)
[03:47:40.935] Timer tick, asking Buildbucket for the build status
[03:47:41.600] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:41.600] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:101:0) after 1m0s
[03:48:41.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:101:0)
[03:48:41.817] Timer tick, asking Buildbucket for the build status
[03:48:41.974] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:41.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:102:0) after 1m0s
[03:49:42.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:102:0)
[03:49:42.043] Timer tick, asking Buildbucket for the build status
[03:49:42.474] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:42.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:103:0) after 1m0s
[03:50:42.550] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:103:0)
[03:50:42.550] Timer tick, asking Buildbucket for the build status
[03:50:42.769] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:42.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:104:0) after 1m0s
[03:51:42.888] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:104:0)
[03:51:42.888] Timer tick, asking Buildbucket for the build status
[03:51:43.081] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:43.081] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:105:0) after 1m0s
[03:52:43.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:105:0)
[03:52:43.101] Timer tick, asking Buildbucket for the build status
[03:52:43.360] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:43.360] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:106:0) after 1m0s
[03:53:43.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:106:0)
[03:53:43.424] Timer tick, asking Buildbucket for the build status
[03:53:43.643] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:43.643] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:107:0) after 1m0s
[03:54:43.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:107:0)
[03:54:43.656] Timer tick, asking Buildbucket for the build status
[03:54:44.193] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:44.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:108:0) after 1m0s
[03:55:44.237] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:108:0)
[03:55:44.237] Timer tick, asking Buildbucket for the build status
[03:55:44.453] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:44.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:109:0) after 1m0s
[03:56:44.503] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:109:0)
[03:56:44.504] Timer tick, asking Buildbucket for the build status
[03:56:44.886] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:44.886] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:110:0) after 1m0s
[03:57:44.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:110:0)
[03:57:44.928] Timer tick, asking Buildbucket for the build status
[03:57:46.396] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:46.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:111:0) after 1m0s
[03:58:46.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:111:0)
[03:58:46.470] Timer tick, asking Buildbucket for the build status
[03:58:46.890] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:46.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:112:0) after 1m0s
[03:59:46.921] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:112:0)
[03:59:46.921] Timer tick, asking Buildbucket for the build status
[03:59:47.791] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:47.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:113:0) after 1m0s
[04:00:47.843] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:113:0)
[04:00:47.843] Timer tick, asking Buildbucket for the build status
[04:00:48.052] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:48.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:114:0) after 1m0s
[04:01:48.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:114:0)
[04:01:48.084] Timer tick, asking Buildbucket for the build status
[04:01:48.879] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:48.879] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:115:0) after 1m0s
[04:02:48.906] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:115:0)
[04:02:48.906] Timer tick, asking Buildbucket for the build status
[04:02:49.594] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:49.594] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:116:0) after 1m0s
[04:03:49.679] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:116:0)
[04:03:49.679] Timer tick, asking Buildbucket for the build status
[04:03:50.011] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:03:50.011] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:117:0) after 1m0s
[04:04:49.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:117:0)
[04:04:49.999] Timer tick, asking Buildbucket for the build status
[04:04:50.190] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:04:50.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:118:0) after 1m0s
[04:05:50.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:118:0)
[04:05:50.248] Timer tick, asking Buildbucket for the build status
[04:05:50.504] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:05:50.504] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:119:0) after 1m0s
[04:06:50.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:119:0)
[04:06:50.551] Timer tick, asking Buildbucket for the build status
[04:06:50.758] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:06:50.758] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:120:0) after 1m0s
[04:07:50.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:120:0)
[04:07:50.819] Timer tick, asking Buildbucket for the build status
[04:07:51.017] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:07:51.017] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:121:0) after 1m0s
[04:08:51.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:121:0)
[04:08:51.084] Timer tick, asking Buildbucket for the build status
[04:08:51.287] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:08:51.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:122:0) after 1m0s
[04:09:51.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:122:0)
[04:09:51.363] Timer tick, asking Buildbucket for the build status
[04:09:51.687] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:09:51.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:123:0) after 1m0s
[04:10:51.709] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:123:0)
[04:10:51.709] Timer tick, asking Buildbucket for the build status
[04:10:51.945] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:10:51.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:124:0) after 1m0s
[04:11:51.978] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:124:0)
[04:11:51.978] Timer tick, asking Buildbucket for the build status
[04:11:53.228] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:53.228] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:125:0) after 1m0s
[04:12:54.018] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:125:0)
[04:12:54.018] Timer tick, asking Buildbucket for the build status
[04:12:54.341] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:54.341] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:126:0) after 1m0s
[04:13:54.401] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:126:0)
[04:13:54.401] Timer tick, asking Buildbucket for the build status
[04:13:54.647] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:54.647] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:127:0) after 1m0s
[04:14:54.767] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:127:0)
[04:14:54.767] Timer tick, asking Buildbucket for the build status
[04:14:55.356] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:55.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:128:0) after 1m0s
[04:15:55.455] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:128:0)
[04:15:55.455] Timer tick, asking Buildbucket for the build status
[04:15:55.963] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:55.963] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:129:0) after 1m0s
[04:16:56.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:129:0)
[04:16:56.437] Timer tick, asking Buildbucket for the build status
[04:16:56.874] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:56.874] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:130:0) after 1m0s
[04:17:57.303] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:130:0)
[04:17:57.303] Timer tick, asking Buildbucket for the build status
[04:17:58.161] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:58.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:131:0) after 1m0s
[04:18:58.252] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:131:0)
[04:18:58.252] Timer tick, asking Buildbucket for the build status
[04:18:59.186] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:59.186] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:132:0) after 1m0s
[04:19:59.544] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:132:0)
[04:19:59.544] Timer tick, asking Buildbucket for the build status
[04:20:00.098] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:00.099] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:133:0) after 1m0s
[04:21:00.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:133:0)
[04:21:00.256] Timer tick, asking Buildbucket for the build status
[04:21:01.059] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:01.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:134:0) after 1m0s
[04:22:01.122] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:134:0)
[04:22:01.122] Timer tick, asking Buildbucket for the build status
[04:22:01.650] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:01.650] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:135:0) after 1m0s
[04:23:02.676] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:135:0)
[04:23:02.676] Timer tick, asking Buildbucket for the build status
[04:23:02.982] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:02.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:136:0) after 1m0s
[04:24:03.182] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:136:0)
[04:24:03.182] Timer tick, asking Buildbucket for the build status
[04:24:03.379] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:03.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:137:0) after 1m0s
[04:25:03.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:137:0)
[04:25:03.478] Timer tick, asking Buildbucket for the build status
[04:25:03.584] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:03.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:138:0) after 1m0s
[04:26:03.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:138:0)
[04:26:03.634] Timer tick, asking Buildbucket for the build status
[04:26:03.897] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:03.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:139:0) after 1m0s
[04:27:03.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:139:0)
[04:27:03.960] Timer tick, asking Buildbucket for the build status
[04:27:04.137] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:04.137] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:140:0) after 1m0s
[04:28:04.212] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:140:0)
[04:28:04.212] Timer tick, asking Buildbucket for the build status
[04:28:05.087] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:05.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:141:0) after 1m0s
[04:29:05.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:141:0)
[04:29:05.152] Timer tick, asking Buildbucket for the build status
[04:29:05.339] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:05.339] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:142:0) after 1m0s
[04:30:05.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:142:0)
[04:30:05.478] Timer tick, asking Buildbucket for the build status
[04:30:05.897] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:05.897] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:143:0) after 1m0s
[04:31:06.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:143:0)
[04:31:06.017] Timer tick, asking Buildbucket for the build status
[04:31:06.232] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:06.232] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:144:0) after 1m0s
[04:32:06.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:144:0)
[04:32:06.344] Timer tick, asking Buildbucket for the build status
[04:32:06.909] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:06.909] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:145:0) after 1m0s
[04:33:06.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:145:0)
[04:33:06.999] Timer tick, asking Buildbucket for the build status
[04:33:07.962] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:07.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:146:0) after 1m0s
[04:34:08.054] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:146:0)
[04:34:08.054] Timer tick, asking Buildbucket for the build status
[04:34:08.327] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:08.327] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:147:0) after 1m0s
[04:35:08.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:147:0)
[04:35:08.356] Timer tick, asking Buildbucket for the build status
[04:35:09.097] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:09.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:148:0) after 1m0s
[04:36:09.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:148:0)
[04:36:09.185] Timer tick, asking Buildbucket for the build status
[04:36:09.357] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:09.357] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:149:0) after 1m0s
[04:37:09.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:149:0)
[04:37:09.390] Timer tick, asking Buildbucket for the build status
[04:37:10.231] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:10.231] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:150:0) after 1m0s
[04:38:10.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:150:0)
[04:38:10.287] Timer tick, asking Buildbucket for the build status
[04:38:10.788] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:10.788] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:151:0) after 1m0s
[04:39:10.839] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:151:0)
[04:39:10.839] Timer tick, asking Buildbucket for the build status
[04:39:11.367] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:11.367] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:152:0) after 1m0s
[04:40:11.400] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:152:0)
[04:40:11.400] Timer tick, asking Buildbucket for the build status
[04:40:11.604] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:11.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:153:0) after 1m0s
[04:41:11.734] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:153:0)
[04:41:11.734] Timer tick, asking Buildbucket for the build status
[04:41:11.945] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:11.945] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:154:0) after 1m0s
[04:42:11.943] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:154:0)
[04:42:11.943] Timer tick, asking Buildbucket for the build status
[04:42:12.245] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:12.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:155:0) after 1m0s
[04:43:12.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:155:0)
[04:43:12.242] Timer tick, asking Buildbucket for the build status
[04:43:13.242] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:13.242] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:156:0) after 1m0s
[04:44:13.288] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:156:0)
[04:44:13.288] Timer tick, asking Buildbucket for the build status
[04:44:13.542] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:13.542] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:157:0) after 1m0s
[04:45:13.586] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:157:0)
[04:45:13.586] Timer tick, asking Buildbucket for the build status
[04:45:14.041] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:14.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:158:0) after 1m0s
[04:46:14.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:158:0)
[04:46:14.166] Timer tick, asking Buildbucket for the build status
[04:46:14.466] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:14.466] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:159:0) after 1m0s
[04:47:14.719] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:159:0)
[04:47:14.719] Timer tick, asking Buildbucket for the build status
[04:47:14.915] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:14.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:160:0) after 1m0s
[04:48:15.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:160:0)
[04:48:15.047] Timer tick, asking Buildbucket for the build status
[04:48:16.340] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:16.340] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:161:0) after 1m0s
[04:49:16.411] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:161:0)
[04:49:16.411] Timer tick, asking Buildbucket for the build status
[04:49:17.065] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:17.065] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:162:0) after 1m0s
[04:50:17.102] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:162:0)
[04:50:17.102] Timer tick, asking Buildbucket for the build status
[04:50:17.458] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:17.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:163:0) after 1m0s
[04:51:17.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:163:0)
[04:51:17.502] Timer tick, asking Buildbucket for the build status
[04:51:17.716] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:17.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:164:0) after 1m0s
[04:52:17.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:164:0)
[04:52:17.765] Timer tick, asking Buildbucket for the build status
[04:52:18.103] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:18.103] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:165:0) after 1m0s
[04:53:18.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:165:0)
[04:53:18.181] Timer tick, asking Buildbucket for the build status
[04:53:18.731] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:18.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:166:0) after 1m0s
[04:54:18.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:166:0)
[04:54:18.724] Timer tick, asking Buildbucket for the build status
[04:54:19.414] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:19.414] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:167:0) after 1m0s
[04:55:19.487] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:167:0)
[04:55:19.487] Timer tick, asking Buildbucket for the build status
[04:55:19.799] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:19.799] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:168:0) after 1m0s
[04:56:19.842] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:168:0)
[04:56:19.842] Timer tick, asking Buildbucket for the build status
[04:56:20.130] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:20.130] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:169:0) after 1m0s
[04:57:20.190] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:169:0)
[04:57:20.190] Timer tick, asking Buildbucket for the build status
[04:57:20.619] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:20.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:170:0) after 1m0s
[04:58:20.659] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:170:0)
[04:58:20.659] Timer tick, asking Buildbucket for the build status
[04:58:21.409] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:21.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:171:0) after 1m0s
[04:59:21.486] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:171:0)
[04:59:21.486] Timer tick, asking Buildbucket for the build status
[04:59:22.458] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:22.458] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:172:0) after 1m0s
[05:00:22.640] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:172:0)
[05:00:22.640] Timer tick, asking Buildbucket for the build status
[05:00:22.901] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:22.901] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:173:0) after 1m0s
[05:01:22.907] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:173:0)
[05:01:22.907] Timer tick, asking Buildbucket for the build status
[05:01:23.073] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:23.073] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:174:0) after 1m0s
[05:02:23.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:174:0)
[05:02:23.097] Timer tick, asking Buildbucket for the build status
[05:02:23.311] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:23.311] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:175:0) after 1m0s
[05:03:23.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:175:0)
[05:03:23.369] Timer tick, asking Buildbucket for the build status
[05:03:23.590] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:23.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:176:0) after 1m0s
[05:04:23.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:176:0)
[05:04:23.648] Timer tick, asking Buildbucket for the build status
[05:04:23.902] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:23.902] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:177:0) after 1m0s
[05:05:23.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:177:0)
[05:05:23.919] Timer tick, asking Buildbucket for the build status
[05:05:24.467] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:24.467] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:178:0) after 1m0s
[05:06:24.502] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:178:0)
[05:06:24.502] Timer tick, asking Buildbucket for the build status
[05:06:24.691] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:24.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:179:0) after 1m0s
[05:07:24.692] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:179:0)
[05:07:24.692] Timer tick, asking Buildbucket for the build status
[05:07:25.429] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:25.429] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:180:0) after 1m0s
[05:08:25.451] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:180:0)
[05:08:25.451] Timer tick, asking Buildbucket for the build status
[05:08:26.195] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:26.195] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:181:0) after 1m0s
[05:09:26.198] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:181:0)
[05:09:26.198] Timer tick, asking Buildbucket for the build status
[05:09:26.571] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:26.571] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:182:0) after 1m0s
[05:10:26.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:182:0)
[05:10:26.671] Timer tick, asking Buildbucket for the build status
[05:10:26.932] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:26.932] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:183:0) after 1m0s
[05:11:27.008] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:183:0)
[05:11:27.008] Timer tick, asking Buildbucket for the build status
[05:11:27.695] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:27.695] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:184:0) after 1m0s
[05:12:27.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:184:0)
[05:12:27.735] Timer tick, asking Buildbucket for the build status
[05:12:28.052] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:28.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:185:0) after 1m0s
[05:13:28.116] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:185:0)
[05:13:28.116] Timer tick, asking Buildbucket for the build status
[05:13:28.355] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:28.355] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:186:0) after 1m0s
[05:14:28.654] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:186:0)
[05:14:28.654] Timer tick, asking Buildbucket for the build status
[05:14:28.814] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:28.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:187:0) after 1m0s
[05:15:28.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:187:0)
[05:15:28.965] Timer tick, asking Buildbucket for the build status
[05:15:29.174] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:29.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:188:0) after 1m0s
[05:16:29.243] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:188:0)
[05:16:29.243] Timer tick, asking Buildbucket for the build status
[05:16:29.406] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:29.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:189:0) after 1m0s
[05:17:29.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:189:0)
[05:17:29.608] Timer tick, asking Buildbucket for the build status
[05:17:29.827] Build 8895040532796621264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:29.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9060470595942973168:190:0) after 1m0s
[05:17:55.697] Received PubSub notification, asking Buildbucket for the build status
[05:17:56.579] Build 8895040532796621264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:17:56.579] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1575436675000645",
"created_by": "project:chromium",
"created_ts": "1575425322687746",
"id": "8895040532796621264",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c7b231946f34fdcac75a7d0ba773c826f1f151e\"}}",
"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-n2xb\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15373, \"got_angle_revision\": \"a5045ac36d1749ad1dbdb5d0f1b864da3d2b3e63\", \"got_dawn_revision\": \"be5c135672275b2f7907d7ce3be471d1800b8408\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"4c7b231946f34fdcac75a7d0ba773c826f1f151e\", \"got_revision_cp\": \"refs/heads/master@{#721313}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"fca575e9fa489e5503349bcf22f6f652c88e1c1e\", \"got_v8_revision\": \"adfb6ba32d881a5bba73f9c7121ca9f8dba881b4\", \"got_v8_revision_cp\": \"refs/heads/8.0.418@{#1}\", \"got_webrtc_revision\": \"89313451d8e2338845716b0ab8760ed0552580f9\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29962}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"4c7b231946f34fdcac75a7d0ba773c826f1f151e\"}, \"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-n2xb\"], \"image\": [\"chrome-win10-1703-19112100-3085293b610\"], \"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\": [\"4693-40b2cd3\"], \"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": "1575425332936578",
"status": "COMPLETED",
"status_changed_ts": "1575436675379173",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15373",
"builder:Windows deterministic",
"buildset:commit/git/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/4c7b231946f34fdcac75a7d0ba773c826f1f151e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9060470595942973168",
"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/8895040532796621264/+/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:48e77c3d11bba210",
"user_agent:luci-scheduler"
],
"updated_ts": "1575436675392851",
"url": "https://ci.chromium.org/b/8895040532796621264",
"utcnow_ts": "1575436676558785"
}
}
[05:17:56.579] Invocation finished in 3h9m16.276501034s with status SUCCEEDED