[08:34:48.156] New invocation is queued and will start shortly
[08:34:49.235] Starting the invocation (attempt 1)
[08:34:49.270] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:34:49.270] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:34:49.271] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9069143611481656736",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"b5be7212043ba6b9091ac816267d51149168011c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9069143611481656736",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/b5be7212043ba6b9091ac816267d51149168011c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5be7212043ba6b9091ac816267d51149168011c",
"gitiles_ref:refs/heads/master"
]
}
[08:34:50.610] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1567154089722230",
"id": "8903713549173416592",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b5be7212043ba6b9091ac816267d51149168011c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1567154090312262",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14576",
"builder:Windows deterministic",
"buildset:commit/git/b5be7212043ba6b9091ac816267d51149168011c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5be7212043ba6b9091ac816267d51149168011c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069143611481656736",
"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/8903713549173416592/+/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": "1567154090312365",
"url": "https://ci.chromium.org/b/8903713549173416592",
"utcnow_ts": "1567154090591424"
}
}
[08:34:50.610] Task URL: https://ci.chromium.org/b/8903713549173416592
[08:34:50.610] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:2:0) after 1m0s
[08:34:52.628] Received PubSub notification, asking Buildbucket for the build status
[08:34:52.841] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:50.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:2:0)
[08:35:50.765] Timer tick, asking Buildbucket for the build status
[08:35:50.891] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:50.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:4:0) after 1m0s
[08:36:51.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:4:0)
[08:36:51.129] Timer tick, asking Buildbucket for the build status
[08:36:51.473] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:51.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:5:0) after 1m0s
[08:37:51.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:5:0)
[08:37:51.687] Timer tick, asking Buildbucket for the build status
[08:37:52.119] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:52.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:6:0) after 1m0s
[08:38:52.286] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:6:0)
[08:38:52.286] Timer tick, asking Buildbucket for the build status
[08:38:52.526] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:52.526] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:7:0) after 1m0s
[08:39:52.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:7:0)
[08:39:52.608] Timer tick, asking Buildbucket for the build status
[08:39:52.778] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:52.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:8:0) after 1m0s
[08:40:52.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:8:0)
[08:40:52.900] Timer tick, asking Buildbucket for the build status
[08:40:53.123] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:53.123] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:9:0) after 1m0s
[08:41:53.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:9:0)
[08:41:53.152] Timer tick, asking Buildbucket for the build status
[08:41:53.672] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:53.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:10:0) after 1m0s
[08:42:53.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:10:0)
[08:42:53.682] Timer tick, asking Buildbucket for the build status
[08:42:53.985] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:53.985] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:11:0) after 1m0s
[08:43:54.022] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:11:0)
[08:43:54.022] Timer tick, asking Buildbucket for the build status
[08:43:54.317] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:54.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:12:0) after 1m0s
[08:44:54.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:12:0)
[08:44:54.362] Timer tick, asking Buildbucket for the build status
[08:44:54.620] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:54.621] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:13:0) after 1m0s
[08:45:54.720] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:13:0)
[08:45:54.720] Timer tick, asking Buildbucket for the build status
[08:45:55.438] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:55.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:14:0) after 1m0s
[08:46:55.526] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:14:0)
[08:46:55.526] Timer tick, asking Buildbucket for the build status
[08:46:55.753] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:55.753] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:15:0) after 1m0s
[08:47:55.791] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:15:0)
[08:47:55.791] Timer tick, asking Buildbucket for the build status
[08:47:56.054] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:56.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:16:0) after 1m0s
[08:48:56.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:16:0)
[08:48:56.107] Timer tick, asking Buildbucket for the build status
[08:48:56.736] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:56.736] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:17:0) after 1m0s
[08:49:56.855] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:17:0)
[08:49:56.855] Timer tick, asking Buildbucket for the build status
[08:49:57.041] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:57.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:18:0) after 1m0s
[08:50:57.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:18:0)
[08:50:57.043] Timer tick, asking Buildbucket for the build status
[08:50:57.334] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:57.334] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:19:0) after 1m0s
[08:51:57.363] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:19:0)
[08:51:57.363] Timer tick, asking Buildbucket for the build status
[08:51:57.561] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:57.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:20:0) after 1m0s
[08:52:57.623] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:20:0)
[08:52:57.623] Timer tick, asking Buildbucket for the build status
[08:52:57.783] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:57.783] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:21:0) after 1m0s
[08:53:57.824] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:21:0)
[08:53:57.824] Timer tick, asking Buildbucket for the build status
[08:53:58.928] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:58.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:22:0) after 1m0s
[08:54:59.012] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:22:0)
[08:54:59.012] Timer tick, asking Buildbucket for the build status
[08:55:00.669] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:00.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:23:0) after 1m0s
[08:56:00.695] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:23:0)
[08:56:00.695] Timer tick, asking Buildbucket for the build status
[08:56:00.940] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:00.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:24:0) after 1m0s
[08:57:00.998] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:24:0)
[08:57:00.998] Timer tick, asking Buildbucket for the build status
[08:57:01.473] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:01.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:25:0) after 1m0s
[08:58:01.506] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:25:0)
[08:58:01.506] Timer tick, asking Buildbucket for the build status
[08:58:02.487] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:02.487] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:26:0) after 1m0s
[08:59:02.524] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:26:0)
[08:59:02.524] Timer tick, asking Buildbucket for the build status
[08:59:03.152] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:03.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:27:0) after 1m0s
[09:00:03.292] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:27:0)
[09:00:03.292] Timer tick, asking Buildbucket for the build status
[09:00:03.526] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:03.527] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:28:0) after 1m0s
[09:01:03.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:28:0)
[09:01:03.582] Timer tick, asking Buildbucket for the build status
[09:01:03.834] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:03.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:29:0) after 1m0s
[09:02:03.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:29:0)
[09:02:03.874] Timer tick, asking Buildbucket for the build status
[09:02:04.316] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:04.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:30:0) after 1m0s
[09:03:04.399] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:30:0)
[09:03:04.399] Timer tick, asking Buildbucket for the build status
[09:03:04.669] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:04.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:31:0) after 1m0s
[09:04:04.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:31:0)
[09:04:04.701] Timer tick, asking Buildbucket for the build status
[09:04:05.373] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:05.373] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:32:0) after 1m0s
[09:05:05.412] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:32:0)
[09:05:05.412] Timer tick, asking Buildbucket for the build status
[09:05:05.881] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:05.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:33:0) after 1m0s
[09:06:05.946] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:33:0)
[09:06:05.946] Timer tick, asking Buildbucket for the build status
[09:06:07.026] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:07.026] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:34:0) after 1m0s
[09:07:07.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:34:0)
[09:07:07.098] Timer tick, asking Buildbucket for the build status
[09:07:07.363] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:07.363] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:35:0) after 1m0s
[09:08:07.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:35:0)
[09:08:07.431] Timer tick, asking Buildbucket for the build status
[09:08:07.726] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:07.726] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:36:0) after 1m0s
[09:09:07.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:36:0)
[09:09:07.753] Timer tick, asking Buildbucket for the build status
[09:09:08.147] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:08.147] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:37:0) after 1m0s
[09:10:08.151] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:37:0)
[09:10:08.152] Timer tick, asking Buildbucket for the build status
[09:10:09.087] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:09.087] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:38:0) after 1m0s
[09:11:09.167] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:38:0)
[09:11:09.167] Timer tick, asking Buildbucket for the build status
[09:11:09.508] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:09.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:39:0) after 1m0s
[09:12:09.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:39:0)
[09:12:09.501] Timer tick, asking Buildbucket for the build status
[09:12:09.739] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:09.739] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:40:0) after 1m0s
[09:13:09.764] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:40:0)
[09:13:09.764] Timer tick, asking Buildbucket for the build status
[09:13:10.820] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:10.820] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:41:0) after 1m0s
[09:14:10.872] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:41:0)
[09:14:10.872] Timer tick, asking Buildbucket for the build status
[09:14:11.822] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:11.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:42:0) after 1m0s
[09:15:11.847] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:42:0)
[09:15:11.847] Timer tick, asking Buildbucket for the build status
[09:15:12.142] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:15:12.143] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:43:0) after 1m0s
[09:16:12.219] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:43:0)
[09:16:12.219] Timer tick, asking Buildbucket for the build status
[09:16:13.934] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:13.934] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:44:0) after 1m0s
[09:17:14.063] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:44:0)
[09:17:14.063] Timer tick, asking Buildbucket for the build status
[09:17:14.388] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:14.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:45:0) after 1m0s
[09:18:14.460] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:45:0)
[09:18:14.460] Timer tick, asking Buildbucket for the build status
[09:18:14.623] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:14.623] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:46:0) after 1m0s
[09:19:14.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:46:0)
[09:19:14.694] Timer tick, asking Buildbucket for the build status
[09:19:15.151] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:15.151] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:47:0) after 1m0s
[09:20:15.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:47:0)
[09:20:15.213] Timer tick, asking Buildbucket for the build status
[09:20:16.329] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:16.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:48:0) after 1m0s
[09:21:16.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:48:0)
[09:21:16.386] Timer tick, asking Buildbucket for the build status
[09:21:16.714] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:16.714] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:49:0) after 1m0s
[09:22:16.755] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:49:0)
[09:22:16.755] Timer tick, asking Buildbucket for the build status
[09:22:17.098] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:17.098] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:50:0) after 1m0s
[09:23:17.192] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:50:0)
[09:23:17.192] Timer tick, asking Buildbucket for the build status
[09:23:17.837] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:17.837] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:51:0) after 1m0s
[09:24:17.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:51:0)
[09:24:17.865] Timer tick, asking Buildbucket for the build status
[09:24:18.146] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:18.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:52:0) after 1m0s
[09:25:18.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:52:0)
[09:25:18.147] Timer tick, asking Buildbucket for the build status
[09:25:18.375] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:18.375] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:53:0) after 1m0s
[09:26:18.406] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:53:0)
[09:26:18.406] Timer tick, asking Buildbucket for the build status
[09:26:19.007] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:19.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:54:0) after 1m0s
[09:27:19.003] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:54:0)
[09:27:19.003] Timer tick, asking Buildbucket for the build status
[09:27:20.133] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:20.133] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:55:0) after 1m0s
[09:28:20.222] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:55:0)
[09:28:20.222] Timer tick, asking Buildbucket for the build status
[09:28:20.900] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:20.900] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:56:0) after 1m0s
[09:29:20.950] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:56:0)
[09:29:20.950] Timer tick, asking Buildbucket for the build status
[09:29:22.285] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:22.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:57:0) after 1m0s
[09:30:22.300] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:57:0)
[09:30:22.300] Timer tick, asking Buildbucket for the build status
[09:30:22.781] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:22.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:58:0) after 1m0s
[09:31:22.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:58:0)
[09:31:22.863] Timer tick, asking Buildbucket for the build status
[09:31:23.977] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:23.977] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:59:0) after 1m0s
[09:32:24.098] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:59:0)
[09:32:24.098] Timer tick, asking Buildbucket for the build status
[09:32:24.349] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:24.349] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:60:0) after 1m0s
[09:33:24.388] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:60:0)
[09:33:24.388] Timer tick, asking Buildbucket for the build status
[09:33:24.632] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:24.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:61:0) after 1m0s
[09:34:24.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:61:0)
[09:34:24.656] Timer tick, asking Buildbucket for the build status
[09:34:27.406] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:27.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:62:0) after 1m0s
[09:35:27.430] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:62:0)
[09:35:27.430] Timer tick, asking Buildbucket for the build status
[09:35:30.051] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:30.051] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:63:0) after 1m0s
[09:36:30.036] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:63:0)
[09:36:30.036] Timer tick, asking Buildbucket for the build status
[09:36:35.791] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:35.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:64:0) after 1m0s
[09:37:35.867] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:64:0)
[09:37:35.867] Timer tick, asking Buildbucket for the build status
[09:37:36.536] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:36.536] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:65:0) after 1m0s
[09:38:36.742] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:65:0)
[09:38:36.742] Timer tick, asking Buildbucket for the build status
[09:38:37.617] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:37.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:66:0) after 1m0s
[09:39:37.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:66:0)
[09:39:37.682] Timer tick, asking Buildbucket for the build status
[09:39:38.121] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:38.121] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:67:0) after 1m0s
[09:40:38.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:67:0)
[09:40:38.176] Timer tick, asking Buildbucket for the build status
[09:40:38.453] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:38.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:68:0) after 1m0s
[09:41:38.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:68:0)
[09:41:38.549] Timer tick, asking Buildbucket for the build status
[09:41:38.820] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:38.821] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:69:0) after 1m0s
[09:42:38.910] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:69:0)
[09:42:38.910] Timer tick, asking Buildbucket for the build status
[09:42:39.604] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:39.604] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:70:0) after 1m0s
[09:43:39.918] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:70:0)
[09:43:39.918] Timer tick, asking Buildbucket for the build status
[09:43:40.172] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:40.172] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:71:0) after 1m0s
[09:44:40.333] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:71:0)
[09:44:40.333] Timer tick, asking Buildbucket for the build status
[09:44:42.751] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:42.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:72:0) after 1m0s
[09:45:42.752] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:72:0)
[09:45:42.752] Timer tick, asking Buildbucket for the build status
[09:45:44.729] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:44.730] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:73:0) after 1m0s
[09:46:44.777] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:73:0)
[09:46:44.777] Timer tick, asking Buildbucket for the build status
[09:46:45.498] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:45.499] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:74:0) after 1m0s
[09:47:45.558] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:74:0)
[09:47:45.558] Timer tick, asking Buildbucket for the build status
[09:47:45.807] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:45.807] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:75:0) after 1m0s
[09:48:45.887] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:75:0)
[09:48:45.887] Timer tick, asking Buildbucket for the build status
[09:48:46.240] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:46.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:76:0) after 1m0s
[09:49:46.242] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:76:0)
[09:49:46.242] Timer tick, asking Buildbucket for the build status
[09:49:46.844] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:46.844] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:77:0) after 1m0s
[09:50:46.893] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:77:0)
[09:50:46.893] Timer tick, asking Buildbucket for the build status
[09:50:47.117] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:47.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:78:0) after 1m0s
[09:51:47.137] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:78:0)
[09:51:47.137] Timer tick, asking Buildbucket for the build status
[09:51:47.447] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:47.447] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:79:0) after 1m0s
[09:52:47.508] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:79:0)
[09:52:47.508] Timer tick, asking Buildbucket for the build status
[09:52:47.952] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:47.952] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:80:0) after 1m0s
[09:53:48.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:80:0)
[09:53:48.043] Timer tick, asking Buildbucket for the build status
[09:53:49.015] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:49.016] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:81:0) after 1m0s
[09:54:49.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:81:0)
[09:54:49.168] Timer tick, asking Buildbucket for the build status
[09:54:49.369] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:49.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:82:0) after 1m0s
[09:55:49.393] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:82:0)
[09:55:49.393] Timer tick, asking Buildbucket for the build status
[09:55:50.092] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:50.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:83:0) after 1m0s
[09:56:50.147] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:83:0)
[09:56:50.147] Timer tick, asking Buildbucket for the build status
[09:56:50.557] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:50.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:84:0) after 1m0s
[09:57:50.538] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:84:0)
[09:57:50.538] Timer tick, asking Buildbucket for the build status
[09:57:51.237] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:51.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:85:0) after 1m0s
[09:58:51.336] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:85:0)
[09:58:51.336] Timer tick, asking Buildbucket for the build status
[09:58:51.510] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:51.510] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:86:0) after 1m0s
[09:59:51.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:86:0)
[09:59:51.634] Timer tick, asking Buildbucket for the build status
[09:59:52.164] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:52.164] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:87:0) after 1m0s
[10:00:52.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:87:0)
[10:00:52.261] Timer tick, asking Buildbucket for the build status
[10:00:52.657] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:52.657] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:88:0) after 1m0s
[10:01:52.708] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:88:0)
[10:01:52.708] Timer tick, asking Buildbucket for the build status
[10:01:53.313] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:53.313] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:89:0) after 1m0s
[10:02:53.370] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:89:0)
[10:02:53.370] Timer tick, asking Buildbucket for the build status
[10:02:55.531] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:55.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:90:0) after 1m0s
[10:03:55.729] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:90:0)
[10:03:55.729] Timer tick, asking Buildbucket for the build status
[10:03:55.958] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:55.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:91:0) after 1m0s
[10:04:56.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:91:0)
[10:04:56.005] Timer tick, asking Buildbucket for the build status
[10:04:56.524] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:56.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:92:0) after 1m0s
[10:05:56.563] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:92:0)
[10:05:56.563] Timer tick, asking Buildbucket for the build status
[10:05:57.396] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:57.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:93:0) after 1m0s
[10:06:57.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:93:0)
[10:06:57.459] Timer tick, asking Buildbucket for the build status
[10:06:58.207] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:58.207] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:94:0) after 1m0s
[10:07:58.276] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:94:0)
[10:07:58.276] Timer tick, asking Buildbucket for the build status
[10:07:58.548] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:58.548] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:95:0) after 1m0s
[10:08:58.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:95:0)
[10:08:58.656] Timer tick, asking Buildbucket for the build status
[10:08:58.854] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:58.854] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:96:0) after 1m0s
[10:09:58.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:96:0)
[10:09:58.966] Timer tick, asking Buildbucket for the build status
[10:09:59.544] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:09:59.544] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:97:0) after 1m0s
[10:10:59.604] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:97:0)
[10:10:59.604] Timer tick, asking Buildbucket for the build status
[10:11:00.662] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:11:00.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:98:0) after 1m0s
[10:12:00.756] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:98:0)
[10:12:00.756] Timer tick, asking Buildbucket for the build status
[10:12:01.021] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:12:01.021] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:99:0) after 1m0s
[10:13:01.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:99:0)
[10:13:01.033] Timer tick, asking Buildbucket for the build status
[10:13:01.352] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:13:01.352] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:100:0) after 1m0s
[10:14:01.384] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:100:0)
[10:14:01.384] Timer tick, asking Buildbucket for the build status
[10:14:03.618] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:14:03.618] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:101:0) after 1m0s
[10:15:03.672] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:101:0)
[10:15:03.672] Timer tick, asking Buildbucket for the build status
[10:15:04.180] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:15:04.180] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:102:0) after 1m0s
[10:16:04.239] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:102:0)
[10:16:04.239] Timer tick, asking Buildbucket for the build status
[10:16:04.615] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:16:04.615] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:103:0) after 1m0s
[10:17:04.663] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:103:0)
[10:17:04.663] Timer tick, asking Buildbucket for the build status
[10:17:04.816] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:17:04.816] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:104:0) after 1m0s
[10:18:05.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:104:0)
[10:18:05.282] Timer tick, asking Buildbucket for the build status
[10:18:05.860] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:18:05.860] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:105:0) after 1m0s
[10:19:05.937] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:105:0)
[10:19:05.937] Timer tick, asking Buildbucket for the build status
[10:19:06.525] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:19:06.525] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:106:0) after 1m0s
[10:20:06.682] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:106:0)
[10:20:06.688] Timer tick, asking Buildbucket for the build status
[10:20:06.923] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:20:06.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:107:0) after 1m0s
[10:21:06.984] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:107:0)
[10:21:06.984] Timer tick, asking Buildbucket for the build status
[10:21:07.709] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:21:07.710] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:108:0) after 1m0s
[10:22:07.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:108:0)
[10:22:07.811] Timer tick, asking Buildbucket for the build status
[10:22:09.174] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:22:09.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:109:0) after 1m0s
[10:23:09.356] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:109:0)
[10:23:09.356] Timer tick, asking Buildbucket for the build status
[10:23:09.531] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:23:09.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:110:0) after 1m0s
[10:24:09.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:110:0)
[10:24:09.726] Timer tick, asking Buildbucket for the build status
[10:24:10.146] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:24:10.146] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:111:0) after 1m0s
[10:25:10.191] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:111:0)
[10:25:10.191] Timer tick, asking Buildbucket for the build status
[10:25:10.777] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:25:10.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:112:0) after 1m0s
[10:26:10.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:112:0)
[10:26:10.851] Timer tick, asking Buildbucket for the build status
[10:26:11.165] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:26:11.165] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:113:0) after 1m0s
[10:27:11.235] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:113:0)
[10:27:11.235] Timer tick, asking Buildbucket for the build status
[10:27:11.516] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:27:11.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:114:0) after 1m0s
[10:28:11.561] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:114:0)
[10:28:11.561] Timer tick, asking Buildbucket for the build status
[10:28:11.750] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:28:11.750] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:115:0) after 1m0s
[10:29:11.903] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:115:0)
[10:29:11.903] Timer tick, asking Buildbucket for the build status
[10:29:12.138] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:29:12.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:116:0) after 1m0s
[10:30:12.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:116:0)
[10:30:12.440] Timer tick, asking Buildbucket for the build status
[10:30:13.663] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:30:13.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:117:0) after 1m0s
[10:31:14.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:117:0)
[10:31:14.096] Timer tick, asking Buildbucket for the build status
[10:31:16.493] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:31:16.493] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:118:0) after 1m0s
[10:32:16.897] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:118:0)
[10:32:16.897] Timer tick, asking Buildbucket for the build status
[10:32:17.302] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:32:17.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:119:0) after 1m0s
[10:33:17.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:119:0)
[10:33:17.334] Timer tick, asking Buildbucket for the build status
[10:33:17.960] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:33:17.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:120:0) after 1m0s
[10:34:18.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:120:0)
[10:34:18.165] Timer tick, asking Buildbucket for the build status
[10:34:18.936] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:34:18.936] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:121:0) after 1m0s
[10:35:19.157] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:121:0)
[10:35:19.157] Timer tick, asking Buildbucket for the build status
[10:35:19.319] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:35:19.319] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:122:0) after 1m0s
[10:36:19.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:122:0)
[10:36:19.507] Timer tick, asking Buildbucket for the build status
[10:36:19.754] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:36:19.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:123:0) after 1m0s
[10:37:19.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:123:0)
[10:37:19.818] Timer tick, asking Buildbucket for the build status
[10:37:20.007] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:37:20.007] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:124:0) after 1m0s
[10:38:20.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:124:0)
[10:38:20.075] Timer tick, asking Buildbucket for the build status
[10:38:21.026] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:38:21.027] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:125:0) after 1m0s
[10:39:21.048] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:125:0)
[10:39:21.048] Timer tick, asking Buildbucket for the build status
[10:39:21.581] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:39:21.581] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:126:0) after 1m0s
[10:40:21.652] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:126:0)
[10:40:21.652] Timer tick, asking Buildbucket for the build status
[10:40:21.830] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:40:21.830] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:127:0) after 1m0s
[10:41:21.892] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:127:0)
[10:41:21.892] Timer tick, asking Buildbucket for the build status
[10:41:22.120] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:41:22.120] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:128:0) after 1m0s
[10:42:22.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:128:0)
[10:42:22.183] Timer tick, asking Buildbucket for the build status
[10:42:24.153] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:42:24.153] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:129:0) after 1m0s
[10:43:24.358] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:129:0)
[10:43:24.358] Timer tick, asking Buildbucket for the build status
[10:43:24.928] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:43:24.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:130:0) after 1m0s
[10:44:25.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:130:0)
[10:44:25.017] Timer tick, asking Buildbucket for the build status
[10:44:25.709] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:44:25.709] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:131:0) after 1m0s
[10:45:25.779] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:131:0)
[10:45:25.779] Timer tick, asking Buildbucket for the build status
[10:45:26.015] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:45:26.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:132:0) after 1m0s
[10:46:26.073] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:132:0)
[10:46:26.073] Timer tick, asking Buildbucket for the build status
[10:46:26.238] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:46:26.238] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:133:0) after 1m0s
[10:47:26.297] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:133:0)
[10:47:26.297] Timer tick, asking Buildbucket for the build status
[10:47:26.742] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:47:26.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:134:0) after 1m0s
[10:48:26.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:134:0)
[10:48:26.813] Timer tick, asking Buildbucket for the build status
[10:48:27.273] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:48:27.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:135:0) after 1m0s
[10:49:27.368] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:135:0)
[10:49:27.368] Timer tick, asking Buildbucket for the build status
[10:49:27.742] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:49:27.742] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:136:0) after 1m0s
[10:50:27.812] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:136:0)
[10:50:27.812] Timer tick, asking Buildbucket for the build status
[10:50:27.976] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:50:27.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:137:0) after 1m0s
[10:51:27.990] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:137:0)
[10:51:27.990] Timer tick, asking Buildbucket for the build status
[10:51:28.239] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:51:28.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:138:0) after 1m0s
[10:52:28.687] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:138:0)
[10:52:28.687] Timer tick, asking Buildbucket for the build status
[10:52:28.926] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:52:28.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:139:0) after 1m0s
[10:53:28.977] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:139:0)
[10:53:28.977] Timer tick, asking Buildbucket for the build status
[10:53:29.737] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:53:29.737] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:140:0) after 1m0s
[10:54:29.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:140:0)
[10:54:29.775] Timer tick, asking Buildbucket for the build status
[10:54:29.939] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:54:29.939] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:141:0) after 1m0s
[10:55:29.964] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:141:0)
[10:55:29.964] Timer tick, asking Buildbucket for the build status
[10:55:30.314] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:30.314] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:142:0) after 1m0s
[10:56:30.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:142:0)
[10:56:30.340] Timer tick, asking Buildbucket for the build status
[10:56:30.506] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:30.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:143:0) after 1m0s
[10:57:30.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:143:0)
[10:57:30.531] Timer tick, asking Buildbucket for the build status
[10:57:31.328] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:31.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:144:0) after 1m0s
[10:58:31.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:144:0)
[10:58:31.385] Timer tick, asking Buildbucket for the build status
[10:58:31.561] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:31.561] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:145:0) after 1m0s
[10:59:31.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:145:0)
[10:59:31.701] Timer tick, asking Buildbucket for the build status
[10:59:31.921] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:31.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:146:0) after 1m0s
[11:00:32.017] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:146:0)
[11:00:32.017] Timer tick, asking Buildbucket for the build status
[11:00:32.236] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:32.236] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:147:0) after 1m0s
[11:01:32.264] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:147:0)
[11:01:32.264] Timer tick, asking Buildbucket for the build status
[11:01:32.794] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:32.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:148:0) after 1m0s
[11:02:32.832] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:148:0)
[11:02:32.832] Timer tick, asking Buildbucket for the build status
[11:02:32.980] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:32.980] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:149:0) after 1m0s
[11:03:32.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:149:0)
[11:03:32.999] Timer tick, asking Buildbucket for the build status
[11:03:33.751] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:33.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:150:0) after 1m0s
[11:04:33.823] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:150:0)
[11:04:33.823] Timer tick, asking Buildbucket for the build status
[11:04:34.054] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:34.054] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:151:0) after 1m0s
[11:05:34.123] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:151:0)
[11:05:34.123] Timer tick, asking Buildbucket for the build status
[11:05:34.307] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:34.307] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:152:0) after 1m0s
[11:06:34.338] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:152:0)
[11:06:34.338] Timer tick, asking Buildbucket for the build status
[11:06:36.991] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:36.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:153:0) after 1m0s
[11:07:37.112] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:153:0)
[11:07:37.112] Timer tick, asking Buildbucket for the build status
[11:07:37.292] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:37.292] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:154:0) after 1m0s
[11:08:37.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:154:0)
[11:08:37.386] Timer tick, asking Buildbucket for the build status
[11:08:37.660] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:37.660] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:155:0) after 1m0s
[11:09:37.876] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:155:0)
[11:09:37.876] Timer tick, asking Buildbucket for the build status
[11:09:38.223] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:38.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:156:0) after 1m0s
[11:10:38.258] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:156:0)
[11:10:38.258] Timer tick, asking Buildbucket for the build status
[11:10:38.638] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:38.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:157:0) after 1m0s
[11:11:38.743] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:157:0)
[11:11:38.743] Timer tick, asking Buildbucket for the build status
[11:11:39.590] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:39.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:158:0) after 1m0s
[11:12:39.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:158:0)
[11:12:39.655] Timer tick, asking Buildbucket for the build status
[11:12:40.052] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:40.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:159:0) after 1m0s
[11:13:40.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:159:0)
[11:13:40.099] Timer tick, asking Buildbucket for the build status
[11:13:40.720] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:40.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:160:0) after 1m0s
[11:14:40.799] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:160:0)
[11:14:40.799] Timer tick, asking Buildbucket for the build status
[11:14:41.046] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:41.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:161:0) after 1m0s
[11:15:41.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:161:0)
[11:15:41.105] Timer tick, asking Buildbucket for the build status
[11:15:41.642] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:41.642] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:162:0) after 1m0s
[11:16:41.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:162:0)
[11:16:41.707] Timer tick, asking Buildbucket for the build status
[11:16:42.022] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:42.022] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:163:0) after 1m0s
[11:17:42.107] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:163:0)
[11:17:42.107] Timer tick, asking Buildbucket for the build status
[11:17:42.302] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:42.302] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:164:0) after 1m0s
[11:18:42.500] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:164:0)
[11:18:42.500] Timer tick, asking Buildbucket for the build status
[11:18:42.769] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:42.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:165:0) after 1m0s
[11:19:42.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:165:0)
[11:19:42.938] Timer tick, asking Buildbucket for the build status
[11:19:43.416] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:43.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:166:0) after 1m0s
[11:20:43.482] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:166:0)
[11:20:43.482] Timer tick, asking Buildbucket for the build status
[11:20:43.638] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:43.638] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:167:0) after 1m0s
[11:21:43.669] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:167:0)
[11:21:43.669] Timer tick, asking Buildbucket for the build status
[11:21:43.840] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:43.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:168:0) after 1m0s
[11:22:43.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:168:0)
[11:22:43.865] Timer tick, asking Buildbucket for the build status
[11:22:44.192] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:44.192] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:169:0) after 1m0s
[11:23:44.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:169:0)
[11:23:44.230] Timer tick, asking Buildbucket for the build status
[11:23:44.443] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:44.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:170:0) after 1m0s
[11:24:44.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:170:0)
[11:24:44.507] Timer tick, asking Buildbucket for the build status
[11:24:45.105] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:45.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:171:0) after 1m0s
[11:25:45.166] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:171:0)
[11:25:45.166] Timer tick, asking Buildbucket for the build status
[11:25:45.433] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:45.433] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:172:0) after 1m0s
[11:26:45.488] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:172:0)
[11:26:45.488] Timer tick, asking Buildbucket for the build status
[11:26:45.702] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:45.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:173:0) after 1m0s
[11:27:45.735] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:173:0)
[11:27:45.735] Timer tick, asking Buildbucket for the build status
[11:27:45.894] Build 8903713549173416592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:45.894] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9069143611481656736:174:0) after 1m0s
[11:28:44.472] Received PubSub notification, asking Buildbucket for the build status
[11:28:45.199] Build 8903713549173416592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[11:28:45.199] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1567164523618971",
"created_by": "project:chromium",
"created_ts": "1567154089722230",
"id": "8903713549173416592",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b5be7212043ba6b9091ac816267d51149168011c\"}}",
"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-bzrg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 14576, \"got_angle_revision\": \"120b61d34ba8da345ea08087a98959c3fa034356\", \"got_dawn_revision\": \"f018c05e44f08859895a451bb83852f4e3dd62c1\", \"got_nacl_revision\": \"058a26f57015051953a727add26e7e26348b9558\", \"got_revision\": \"b5be7212043ba6b9091ac816267d51149168011c\", \"got_revision_cp\": \"refs/heads/master@{#691975}\", \"got_swarming_client_revision\": \"96f125709acfd0b48fc1e5dae7d6ea42291726ac\", \"got_v8_revision\": \"be6134761ccf7255bd481d6dae89e39a4eaadb19\", \"got_v8_revision_cp\": \"refs/heads/7.8.231@{#1}\", \"got_webrtc_revision\": \"25eb47ccf18f0764eb9a94d586eb8b74ffd712d3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29010}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"b5be7212043ba6b9091ac816267d51149168011c\"}, \"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-bzrg\"], \"image\": [\"chrome-win10-1703-19072400-fedda89f1f1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4397-8786906\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1567154091634517",
"status": "COMPLETED",
"status_changed_ts": "1567164524010702",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/14576",
"builder:Windows deterministic",
"buildset:commit/git/b5be7212043ba6b9091ac816267d51149168011c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b5be7212043ba6b9091ac816267d51149168011c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9069143611481656736",
"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/8903713549173416592/+/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:46fa7b3c63a7d510",
"user_agent:luci-scheduler"
],
"updated_ts": "1567164524076789",
"url": "https://ci.chromium.org/b/8903713549173416592",
"utcnow_ts": "1567164525155866"
}
}
[11:28:45.199] Invocation finished in 2h53m57.061459257s with status SUCCEEDED