[05:22:00.500] New invocation is queued and will start shortly
[05:22:01.570] Starting the invocation (attempt 1)
[05:22:01.646] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:22:01.646] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:22:01.646] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058827686875737872",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e57c38a8e6ee1a469694c210681ae456adbb1bc5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9058827686875737872",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"gitiles_ref:refs/heads/master"
]
}
[05:22:02.546] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576992121906077",
"id": "8893397624738619184",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e57c38a8e6ee1a469694c210681ae456adbb1bc5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576992122270704",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15511",
"builder:Windows deterministic",
"buildset:commit/git/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058827686875737872",
"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/8893397624738619184/+/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": "1576992122270804",
"url": "https://ci.chromium.org/b/8893397624738619184",
"utcnow_ts": "1576992122535468"
}
}
[05:22:02.546] Task URL: https://ci.chromium.org/b/8893397624738619184
[05:22:02.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:2:0) after 1m0s
[05:22:06.454] Received PubSub notification, asking Buildbucket for the build status
[05:22:06.594] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:02.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:2:0)
[05:23:02.632] Timer tick, asking Buildbucket for the build status
[05:23:03.256] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:03.256] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:4:0) after 1m0s
[05:24:03.313] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:4:0)
[05:24:03.313] Timer tick, asking Buildbucket for the build status
[05:24:03.462] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:03.462] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:5:0) after 1m0s
[05:25:03.587] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:5:0)
[05:25:03.587] Timer tick, asking Buildbucket for the build status
[05:25:03.937] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:03.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:6:0) after 1m0s
[05:26:04.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:6:0)
[05:26:04.128] Timer tick, asking Buildbucket for the build status
[05:26:04.863] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:04.863] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:7:0) after 1m0s
[05:27:04.874] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:7:0)
[05:27:04.874] Timer tick, asking Buildbucket for the build status
[05:27:05.122] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:05.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:8:0) after 1m0s
[05:28:05.152] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:8:0)
[05:28:05.152] Timer tick, asking Buildbucket for the build status
[05:28:05.415] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:05.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:9:0) after 1m0s
[05:29:05.437] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:9:0)
[05:29:05.437] Timer tick, asking Buildbucket for the build status
[05:29:05.598] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:05.598] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:10:0) after 1m0s
[05:30:05.620] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:10:0)
[05:30:05.620] Timer tick, asking Buildbucket for the build status
[05:30:05.962] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:05.962] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:11:0) after 1m0s
[05:31:06.715] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:11:0)
[05:31:06.715] Timer tick, asking Buildbucket for the build status
[05:31:07.067] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:07.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:12:0) after 1m0s
[05:32:07.099] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:12:0)
[05:32:07.099] Timer tick, asking Buildbucket for the build status
[05:32:07.251] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:07.251] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:13:0) after 1m0s
[05:33:07.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:13:0)
[05:33:07.348] Timer tick, asking Buildbucket for the build status
[05:33:07.488] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:07.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:14:0) after 1m0s
[05:34:07.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:14:0)
[05:34:07.556] Timer tick, asking Buildbucket for the build status
[05:34:08.703] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:08.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:15:0) after 1m0s
[05:35:08.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:15:0)
[05:35:08.746] Timer tick, asking Buildbucket for the build status
[05:35:09.637] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:09.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:16:0) after 1m0s
[05:36:09.844] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:16:0)
[05:36:09.844] Timer tick, asking Buildbucket for the build status
[05:36:10.097] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:10.097] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:17:0) after 1m0s
[05:37:10.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:17:0)
[05:37:10.213] Timer tick, asking Buildbucket for the build status
[05:37:10.382] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:18:0) after 1m0s
[05:38:10.694] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:18:0)
[05:38:10.694] Timer tick, asking Buildbucket for the build status
[05:38:10.827] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:10.827] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:19:0) after 1m0s
[05:39:10.999] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:19:0)
[05:39:10.999] Timer tick, asking Buildbucket for the build status
[05:39:11.488] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:11.488] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:20:0) after 1m0s
[05:40:11.690] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:20:0)
[05:40:11.690] Timer tick, asking Buildbucket for the build status
[05:40:12.198] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:12.198] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:21:0) after 1m0s
[05:41:12.431] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:21:0)
[05:41:12.431] Timer tick, asking Buildbucket for the build status
[05:41:12.573] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:12.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:22:0) after 1m0s
[05:42:13.963] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:22:0)
[05:42:13.963] Timer tick, asking Buildbucket for the build status
[05:42:14.470] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:14.470] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:23:0) after 1m0s
[05:43:14.562] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:23:0)
[05:43:14.562] Timer tick, asking Buildbucket for the build status
[05:43:14.757] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:14.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:24:0) after 1m0s
[05:44:14.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:24:0)
[05:44:14.822] Timer tick, asking Buildbucket for the build status
[05:44:15.043] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:15.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:25:0) after 1m0s
[05:45:15.154] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:25:0)
[05:45:15.154] Timer tick, asking Buildbucket for the build status
[05:45:15.345] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:15.345] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:26:0) after 1m0s
[05:46:15.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:26:0)
[05:46:15.340] Timer tick, asking Buildbucket for the build status
[05:46:15.511] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:15.511] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:27:0) after 1m0s
[05:47:15.531] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:27:0)
[05:47:15.531] Timer tick, asking Buildbucket for the build status
[05:47:15.678] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:15.678] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:28:0) after 1m0s
[05:48:15.751] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:28:0)
[05:48:15.751] Timer tick, asking Buildbucket for the build status
[05:48:16.049] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:16.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:29:0) after 1m0s
[05:49:16.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:29:0)
[05:49:16.087] Timer tick, asking Buildbucket for the build status
[05:49:16.389] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:16.389] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:30:0) after 1m0s
[05:50:16.573] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:30:0)
[05:50:16.573] Timer tick, asking Buildbucket for the build status
[05:50:17.142] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:17.142] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:31:0) after 1m0s
[05:51:17.165] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:31:0)
[05:51:17.165] Timer tick, asking Buildbucket for the build status
[05:51:17.328] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:17.328] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:32:0) after 1m0s
[05:52:17.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:32:0)
[05:52:17.369] Timer tick, asking Buildbucket for the build status
[05:52:17.528] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:17.528] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:33:0) after 1m0s
[05:53:17.618] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:33:0)
[05:53:17.618] Timer tick, asking Buildbucket for the build status
[05:53:18.947] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:18.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:34:0) after 1m0s
[05:54:18.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:34:0)
[05:54:18.965] Timer tick, asking Buildbucket for the build status
[05:54:19.273] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:19.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:35:0) after 1m0s
[05:55:19.299] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:35:0)
[05:55:19.299] Timer tick, asking Buildbucket for the build status
[05:55:19.505] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:19.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:36:0) after 1m0s
[05:56:19.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:36:0)
[05:56:19.582] Timer tick, asking Buildbucket for the build status
[05:56:20.277] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:20.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:37:0) after 1m0s
[05:57:20.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:37:0)
[05:57:20.296] Timer tick, asking Buildbucket for the build status
[05:57:20.496] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:20.496] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:38:0) after 1m0s
[05:58:20.625] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:38:0)
[05:58:20.625] Timer tick, asking Buildbucket for the build status
[05:58:20.794] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:39:0) after 1m0s
[05:59:20.865] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:39:0)
[05:59:20.865] Timer tick, asking Buildbucket for the build status
[05:59:20.987] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:20.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:40:0) after 1m0s
[06:00:21.135] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:40:0)
[06:00:21.135] Timer tick, asking Buildbucket for the build status
[06:00:22.253] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:22.253] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:41:0) after 1m0s
[06:01:22.265] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:41:0)
[06:01:22.265] Timer tick, asking Buildbucket for the build status
[06:01:22.720] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:22.720] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:42:0) after 1m0s
[06:02:22.749] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:42:0)
[06:02:22.749] Timer tick, asking Buildbucket for the build status
[06:02:23.182] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:23.182] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:43:0) after 1m0s
[06:03:23.223] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:43:0)
[06:03:23.223] Timer tick, asking Buildbucket for the build status
[06:03:23.663] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:23.663] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:44:0) after 1m0s
[06:04:23.704] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:44:0)
[06:04:23.704] Timer tick, asking Buildbucket for the build status
[06:04:23.928] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:23.928] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:45:0) after 1m0s
[06:05:23.948] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:45:0)
[06:05:23.948] Timer tick, asking Buildbucket for the build status
[06:05:24.241] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:24.241] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:46:0) after 1m0s
[06:06:24.312] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:46:0)
[06:06:24.312] Timer tick, asking Buildbucket for the build status
[06:06:24.890] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:24.890] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:47:0) after 1m0s
[06:07:24.922] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:47:0)
[06:07:24.922] Timer tick, asking Buildbucket for the build status
[06:07:25.213] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:25.213] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:48:0) after 1m0s
[06:08:25.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:48:0)
[06:08:25.238] Timer tick, asking Buildbucket for the build status
[06:08:25.399] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:25.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:49:0) after 1m0s
[06:09:25.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:49:0)
[06:09:25.475] Timer tick, asking Buildbucket for the build status
[06:09:25.681] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:25.681] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:50:0) after 1m0s
[06:10:25.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:50:0)
[06:10:25.707] Timer tick, asking Buildbucket for the build status
[06:10:26.184] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:26.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:51:0) after 1m0s
[06:11:26.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:51:0)
[06:11:26.216] Timer tick, asking Buildbucket for the build status
[06:11:26.513] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:26.513] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:52:0) after 1m0s
[06:12:26.497] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:52:0)
[06:12:26.497] Timer tick, asking Buildbucket for the build status
[06:12:26.672] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:26.672] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:53:0) after 1m0s
[06:13:26.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:53:0)
[06:13:26.773] Timer tick, asking Buildbucket for the build status
[06:13:27.039] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:27.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:54:0) after 1m0s
[06:14:27.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:54:0)
[06:14:27.132] Timer tick, asking Buildbucket for the build status
[06:14:27.986] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:27.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:55:0) after 1m0s
[06:15:28.010] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:55:0)
[06:15:28.010] Timer tick, asking Buildbucket for the build status
[06:15:28.326] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:28.326] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:56:0) after 1m0s
[06:16:28.381] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:56:0)
[06:16:28.381] Timer tick, asking Buildbucket for the build status
[06:16:29.224] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:29.224] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:57:0) after 1m0s
[06:17:29.284] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:57:0)
[06:17:29.284] Timer tick, asking Buildbucket for the build status
[06:17:29.540] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:29.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:58:0) after 1m0s
[06:18:29.570] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:58:0)
[06:18:29.570] Timer tick, asking Buildbucket for the build status
[06:18:30.064] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:30.064] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:59:0) after 1m0s
[06:19:30.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:59:0)
[06:19:30.164] Timer tick, asking Buildbucket for the build status
[06:19:30.322] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:30.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:60:0) after 1m0s
[06:20:30.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:60:0)
[06:20:30.348] Timer tick, asking Buildbucket for the build status
[06:20:30.568] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:30.568] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:61:0) after 1m0s
[06:21:30.596] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:61:0)
[06:21:30.596] Timer tick, asking Buildbucket for the build status
[06:21:30.849] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:30.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:62:0) after 1m0s
[06:22:30.886] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:62:0)
[06:22:30.886] Timer tick, asking Buildbucket for the build status
[06:22:31.188] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:31.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:63:0) after 1m0s
[06:23:31.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:63:0)
[06:23:31.271] Timer tick, asking Buildbucket for the build status
[06:23:31.754] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:31.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:64:0) after 1m0s
[06:24:31.774] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:64:0)
[06:24:31.774] Timer tick, asking Buildbucket for the build status
[06:24:31.960] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:31.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:65:0) after 1m0s
[06:25:32.045] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:65:0)
[06:25:32.045] Timer tick, asking Buildbucket for the build status
[06:25:32.479] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:32.479] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:66:0) after 1m0s
[06:26:32.517] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:66:0)
[06:26:32.517] Timer tick, asking Buildbucket for the build status
[06:26:33.155] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:33.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:67:0) after 1m0s
[06:27:33.183] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:67:0)
[06:27:33.183] Timer tick, asking Buildbucket for the build status
[06:27:33.329] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:33.329] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:68:0) after 1m0s
[06:28:33.450] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:68:0)
[06:28:33.450] Timer tick, asking Buildbucket for the build status
[06:28:33.626] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:33.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:69:0) after 1m0s
[06:29:33.838] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:69:0)
[06:29:33.838] Timer tick, asking Buildbucket for the build status
[06:29:34.664] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:34.664] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:70:0) after 1m0s
[06:30:34.736] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:70:0)
[06:30:34.737] Timer tick, asking Buildbucket for the build status
[06:30:35.342] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:35.342] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:71:0) after 1m0s
[06:31:35.386] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:71:0)
[06:31:35.386] Timer tick, asking Buildbucket for the build status
[06:31:35.540] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:35.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:72:0) after 1m0s
[06:32:35.639] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:72:0)
[06:32:35.639] Timer tick, asking Buildbucket for the build status
[06:32:35.840] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:35.840] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:73:0) after 1m0s
[06:33:35.877] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:73:0)
[06:33:35.877] Timer tick, asking Buildbucket for the build status
[06:33:36.781] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:36.781] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:74:0) after 1m0s
[06:34:36.801] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:74:0)
[06:34:36.801] Timer tick, asking Buildbucket for the build status
[06:34:36.986] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:36.986] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:75:0) after 1m0s
[06:35:36.965] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:75:0)
[06:35:36.965] Timer tick, asking Buildbucket for the build status
[06:35:37.388] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:37.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:76:0) after 1m0s
[06:36:37.478] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:76:0)
[06:36:37.478] Timer tick, asking Buildbucket for the build status
[06:36:37.637] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:37.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:77:0) after 1m0s
[06:37:37.633] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:77:0)
[06:37:37.633] Timer tick, asking Buildbucket for the build status
[06:37:37.778] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:37.778] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:78:0) after 1m0s
[06:38:37.814] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:78:0)
[06:38:37.814] Timer tick, asking Buildbucket for the build status
[06:38:38.033] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:38.033] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:79:0) after 1m0s
[06:39:38.056] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:79:0)
[06:39:38.056] Timer tick, asking Buildbucket for the build status
[06:39:38.464] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:38.464] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:80:0) after 1m0s
[06:40:38.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:80:0)
[06:40:38.510] Timer tick, asking Buildbucket for the build status
[06:40:38.685] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:38.685] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:81:0) after 1m0s
[06:41:38.741] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:81:0)
[06:41:38.741] Timer tick, asking Buildbucket for the build status
[06:41:38.922] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:38.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:82:0) after 1m0s
[06:42:38.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:82:0)
[06:42:38.940] Timer tick, asking Buildbucket for the build status
[06:42:39.439] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:39.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:83:0) after 1m0s
[06:43:39.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:83:0)
[06:43:39.443] Timer tick, asking Buildbucket for the build status
[06:43:39.585] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:39.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:84:0) after 1m0s
[06:44:39.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:84:0)
[06:44:39.628] Timer tick, asking Buildbucket for the build status
[06:44:40.288] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:40.288] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:85:0) after 1m0s
[06:45:40.372] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:85:0)
[06:45:40.372] Timer tick, asking Buildbucket for the build status
[06:45:40.549] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:40.549] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:86:0) after 1m0s
[06:46:40.632] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:86:0)
[06:46:40.632] Timer tick, asking Buildbucket for the build status
[06:46:40.971] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:40.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:87:0) after 1m0s
[06:47:41.046] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:87:0)
[06:47:41.046] Timer tick, asking Buildbucket for the build status
[06:47:41.438] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:41.438] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:88:0) after 1m0s
[06:48:41.461] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:88:0)
[06:48:41.461] Timer tick, asking Buildbucket for the build status
[06:48:41.635] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:41.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:89:0) after 1m0s
[06:49:41.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:89:0)
[06:49:41.638] Timer tick, asking Buildbucket for the build status
[06:49:41.881] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:41.881] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:90:0) after 1m0s
[06:50:41.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:90:0)
[06:50:41.870] Timer tick, asking Buildbucket for the build status
[06:50:42.036] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:42.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:91:0) after 1m0s
[06:51:42.177] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:91:0)
[06:51:42.177] Timer tick, asking Buildbucket for the build status
[06:51:42.388] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:42.388] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:92:0) after 1m0s
[06:52:42.507] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:92:0)
[06:52:42.508] Timer tick, asking Buildbucket for the build status
[06:52:43.546] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:43.546] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:93:0) after 1m0s
[06:53:43.572] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:93:0)
[06:53:43.572] Timer tick, asking Buildbucket for the build status
[06:53:44.048] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:44.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:94:0) after 1m0s
[06:54:44.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:94:0)
[06:54:44.092] Timer tick, asking Buildbucket for the build status
[06:54:44.237] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:95:0) after 1m0s
[06:55:44.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:95:0)
[06:55:44.369] Timer tick, asking Buildbucket for the build status
[06:55:45.075] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:45.075] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:96:0) after 1m0s
[06:56:45.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:96:0)
[06:56:45.230] Timer tick, asking Buildbucket for the build status
[06:56:45.393] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:45.393] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:97:0) after 1m0s
[06:57:45.419] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:97:0)
[06:57:45.419] Timer tick, asking Buildbucket for the build status
[06:57:45.896] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:45.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:98:0) after 1m0s
[06:58:46.170] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:98:0)
[06:58:46.170] Timer tick, asking Buildbucket for the build status
[06:58:46.480] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:46.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:99:0) after 1m0s
[06:59:46.602] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:99:0)
[06:59:46.602] Timer tick, asking Buildbucket for the build status
[06:59:46.755] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:46.756] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:100:0) after 1m0s
[07:00:46.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:100:0)
[07:00:46.940] Timer tick, asking Buildbucket for the build status
[07:00:47.169] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:47.169] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:101:0) after 1m0s
[07:01:47.200] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:101:0)
[07:01:47.200] Timer tick, asking Buildbucket for the build status
[07:01:47.503] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:102:0) after 1m0s
[07:02:47.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:102:0)
[07:02:47.534] Timer tick, asking Buildbucket for the build status
[07:02:48.203] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:48.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:103:0) after 1m0s
[07:03:48.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:103:0)
[07:03:48.307] Timer tick, asking Buildbucket for the build status
[07:03:48.677] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:48.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:104:0) after 1m0s
[07:04:48.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:104:0)
[07:04:48.699] Timer tick, asking Buildbucket for the build status
[07:04:48.873] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:48.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:105:0) after 1m0s
[07:05:48.912] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:105:0)
[07:05:48.912] Timer tick, asking Buildbucket for the build status
[07:05:49.094] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:49.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:106:0) after 1m0s
[07:06:53.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:106:0)
[07:06:53.822] Timer tick, asking Buildbucket for the build status
[07:06:54.477] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:54.477] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:107:0) after 1m0s
[07:07:54.551] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:107:0)
[07:07:54.551] Timer tick, asking Buildbucket for the build status
[07:07:54.751] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:54.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:108:0) after 1m0s
[07:08:54.746] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:108:0)
[07:08:54.746] Timer tick, asking Buildbucket for the build status
[07:08:54.895] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:54.895] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:109:0) after 1m0s
[07:09:55.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:109:0)
[07:09:55.092] Timer tick, asking Buildbucket for the build status
[07:09:55.455] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:55.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:110:0) after 1m0s
[07:10:55.548] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:110:0)
[07:10:55.548] Timer tick, asking Buildbucket for the build status
[07:10:55.791] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:55.791] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:111:0) after 1m0s
[07:11:56.024] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:111:0)
[07:11:56.024] Timer tick, asking Buildbucket for the build status
[07:11:56.183] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:56.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:112:0) after 1m0s
[07:12:56.213] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:112:0)
[07:12:56.213] Timer tick, asking Buildbucket for the build status
[07:12:56.973] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:56.973] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:113:0) after 1m0s
[07:13:57.101] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:113:0)
[07:13:57.101] Timer tick, asking Buildbucket for the build status
[07:13:57.637] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:57.637] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:114:0) after 1m0s
[07:14:57.773] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:114:0)
[07:14:57.773] Timer tick, asking Buildbucket for the build status
[07:14:57.947] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:57.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:115:0) after 1m0s
[07:15:58.085] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:115:0)
[07:15:58.085] Timer tick, asking Buildbucket for the build status
[07:15:58.435] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:58.435] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:116:0) after 1m0s
[07:16:58.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:116:0)
[07:16:58.519] Timer tick, asking Buildbucket for the build status
[07:16:59.018] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:59.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:117:0) after 1m0s
[07:17:59.202] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:117:0)
[07:17:59.202] Timer tick, asking Buildbucket for the build status
[07:17:59.593] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:59.593] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:118:0) after 1m0s
[07:18:59.617] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:118:0)
[07:18:59.617] Timer tick, asking Buildbucket for the build status
[07:19:00.563] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:00.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:119:0) after 1m0s
[07:20:00.788] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:119:0)
[07:20:00.788] Timer tick, asking Buildbucket for the build status
[07:20:01.104] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:01.104] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:120:0) after 1m0s
[07:21:01.225] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:120:0)
[07:21:01.225] Timer tick, asking Buildbucket for the build status
[07:21:01.796] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:01.796] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:121:0) after 1m0s
[07:22:01.899] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:121:0)
[07:22:01.899] Timer tick, asking Buildbucket for the build status
[07:22:02.585] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:02.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:122:0) after 1m0s
[07:23:02.569] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:122:0)
[07:23:02.569] Timer tick, asking Buildbucket for the build status
[07:23:02.913] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:123:0) after 1m0s
[07:24:02.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:123:0)
[07:24:02.988] Timer tick, asking Buildbucket for the build status
[07:24:04.457] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:04.457] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:124:0) after 1m0s
[07:25:04.599] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:124:0)
[07:25:04.599] Timer tick, asking Buildbucket for the build status
[07:25:04.989] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:04.989] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:125:0) after 1m0s
[07:26:05.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:125:0)
[07:26:05.047] Timer tick, asking Buildbucket for the build status
[07:26:05.248] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:05.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:126:0) after 1m0s
[07:27:05.385] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:126:0)
[07:27:05.385] Timer tick, asking Buildbucket for the build status
[07:27:05.634] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:05.634] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:127:0) after 1m0s
[07:28:05.670] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:127:0)
[07:28:05.670] Timer tick, asking Buildbucket for the build status
[07:28:05.995] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:05.995] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:128:0) after 1m0s
[07:29:06.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:128:0)
[07:29:06.079] Timer tick, asking Buildbucket for the build status
[07:29:06.670] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:06.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:129:0) after 1m0s
[07:30:06.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:129:0)
[07:30:06.802] Timer tick, asking Buildbucket for the build status
[07:30:07.014] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:07.014] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:130:0) after 1m0s
[07:31:07.185] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:130:0)
[07:31:07.185] Timer tick, asking Buildbucket for the build status
[07:31:07.743] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:07.743] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:131:0) after 1m0s
[07:32:07.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:131:0)
[07:32:07.988] Timer tick, asking Buildbucket for the build status
[07:32:08.183] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:08.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:132:0) after 1m0s
[07:33:08.277] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:132:0)
[07:33:08.277] Timer tick, asking Buildbucket for the build status
[07:33:09.204] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:09.204] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:133:0) after 1m0s
[07:34:09.233] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:133:0)
[07:34:09.233] Timer tick, asking Buildbucket for the build status
[07:34:09.403] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:09.403] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:134:0) after 1m0s
[07:35:09.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:134:0)
[07:35:09.454] Timer tick, asking Buildbucket for the build status
[07:35:09.947] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:09.947] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:135:0) after 1m0s
[07:36:09.966] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:135:0)
[07:36:09.966] Timer tick, asking Buildbucket for the build status
[07:36:10.240] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:10.240] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:136:0) after 1m0s
[07:37:10.416] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:136:0)
[07:37:10.416] Timer tick, asking Buildbucket for the build status
[07:37:10.585] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:10.585] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:137:0) after 1m0s
[07:38:10.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:137:0)
[07:38:10.621] Timer tick, asking Buildbucket for the build status
[07:38:10.769] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:10.769] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:138:0) after 1m0s
[07:39:10.807] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:138:0)
[07:39:10.807] Timer tick, asking Buildbucket for the build status
[07:39:11.041] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:11.041] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:139:0) after 1m0s
[07:40:11.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:139:0)
[07:40:11.087] Timer tick, asking Buildbucket for the build status
[07:40:11.272] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:11.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:140:0) after 1m0s
[07:41:11.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:140:0)
[07:41:11.325] Timer tick, asking Buildbucket for the build status
[07:41:11.502] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:11.502] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:141:0) after 1m0s
[07:42:11.598] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:141:0)
[07:42:11.598] Timer tick, asking Buildbucket for the build status
[07:42:11.760] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:11.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:142:0) after 1m0s
[07:43:11.766] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:142:0)
[07:43:11.766] Timer tick, asking Buildbucket for the build status
[07:43:11.933] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:11.933] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:143:0) after 1m0s
[07:44:11.960] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:143:0)
[07:44:11.960] Timer tick, asking Buildbucket for the build status
[07:44:12.563] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:12.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:144:0) after 1m0s
[07:45:12.661] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:144:0)
[07:45:12.661] Timer tick, asking Buildbucket for the build status
[07:45:12.822] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:12.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:145:0) after 1m0s
[07:46:12.891] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:145:0)
[07:46:12.891] Timer tick, asking Buildbucket for the build status
[07:46:13.402] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:13.402] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:146:0) after 1m0s
[07:47:13.454] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:146:0)
[07:47:13.454] Timer tick, asking Buildbucket for the build status
[07:47:13.644] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:13.644] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:147:0) after 1m0s
[07:48:13.671] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:147:0)
[07:48:13.671] Timer tick, asking Buildbucket for the build status
[07:48:13.800] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:13.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:148:0) after 1m0s
[07:49:13.826] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:148:0)
[07:49:13.826] Timer tick, asking Buildbucket for the build status
[07:49:14.199] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:14.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:149:0) after 1m0s
[07:50:14.271] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:149:0)
[07:50:14.271] Timer tick, asking Buildbucket for the build status
[07:50:14.473] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:14.473] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:150:0) after 1m0s
[07:51:14.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:150:0)
[07:51:14.534] Timer tick, asking Buildbucket for the build status
[07:51:14.708] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:14.708] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:151:0) after 1m0s
[07:52:14.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:151:0)
[07:52:14.781] Timer tick, asking Buildbucket for the build status
[07:52:15.034] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:15.035] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:152:0) after 1m0s
[07:53:15.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:152:0)
[07:53:15.078] Timer tick, asking Buildbucket for the build status
[07:53:15.691] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:15.691] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:153:0) after 1m0s
[07:54:15.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:153:0)
[07:54:15.811] Timer tick, asking Buildbucket for the build status
[07:54:15.976] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:15.976] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:154:0) after 1m0s
[07:55:15.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:154:0)
[07:55:15.979] Timer tick, asking Buildbucket for the build status
[07:55:16.188] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:16.188] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:155:0) after 1m0s
[07:56:16.250] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:155:0)
[07:56:16.250] Timer tick, asking Buildbucket for the build status
[07:56:16.406] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:16.406] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:156:0) after 1m0s
[07:57:16.440] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:156:0)
[07:57:16.440] Timer tick, asking Buildbucket for the build status
[07:57:16.617] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:16.617] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:157:0) after 1m0s
[07:58:16.642] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:157:0)
[07:58:16.642] Timer tick, asking Buildbucket for the build status
[07:58:16.960] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:16.960] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:158:0) after 1m0s
[07:59:17.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:158:0)
[07:59:17.039] Timer tick, asking Buildbucket for the build status
[07:59:17.272] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:17.272] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:159:0) after 1m0s
[08:00:17.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:159:0)
[08:00:17.308] Timer tick, asking Buildbucket for the build status
[08:00:20.640] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:20.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:160:0) after 1m0s
[08:01:20.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:160:0)
[08:01:20.665] Timer tick, asking Buildbucket for the build status
[08:01:20.909] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:20.910] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:161:0) after 1m0s
[08:02:20.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:161:0)
[08:02:20.940] Timer tick, asking Buildbucket for the build status
[08:02:21.260] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:21.260] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:162:0) after 1m0s
[08:03:21.449] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:162:0)
[08:03:21.449] Timer tick, asking Buildbucket for the build status
[08:03:21.703] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:21.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:163:0) after 1m0s
[08:04:21.725] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:163:0)
[08:04:21.725] Timer tick, asking Buildbucket for the build status
[08:04:21.974] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:21.974] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:164:0) after 1m0s
[08:05:22.078] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:164:0)
[08:05:22.078] Timer tick, asking Buildbucket for the build status
[08:05:23.310] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:23.310] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:165:0) after 1m0s
[08:06:23.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:165:0)
[08:06:23.369] Timer tick, asking Buildbucket for the build status
[08:06:23.619] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:23.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:166:0) after 1m0s
[08:07:23.608] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:166:0)
[08:07:23.608] Timer tick, asking Buildbucket for the build status
[08:07:23.861] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:23.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:167:0) after 1m0s
[08:08:23.909] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:167:0)
[08:08:23.909] Timer tick, asking Buildbucket for the build status
[08:08:24.210] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:24.210] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:168:0) after 1m0s
[08:09:24.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:168:0)
[08:09:24.344] Timer tick, asking Buildbucket for the build status
[08:09:24.522] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:24.522] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:169:0) after 1m0s
[08:10:24.592] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:169:0)
[08:10:24.592] Timer tick, asking Buildbucket for the build status
[08:10:24.764] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:24.764] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:170:0) after 1m0s
[08:11:24.955] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:170:0)
[08:11:24.955] Timer tick, asking Buildbucket for the build status
[08:11:25.465] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:25.465] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:171:0) after 1m0s
[08:12:25.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:171:0)
[08:12:25.496] Timer tick, asking Buildbucket for the build status
[08:12:25.790] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:25.790] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:172:0) after 1m0s
[08:13:25.835] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:172:0)
[08:13:25.835] Timer tick, asking Buildbucket for the build status
[08:13:26.043] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:26.043] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:173:0) after 1m0s
[08:14:26.181] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:173:0)
[08:14:26.181] Timer tick, asking Buildbucket for the build status
[08:14:26.405] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:26.405] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:174:0) after 1m0s
[08:15:26.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:174:0)
[08:15:26.463] Timer tick, asking Buildbucket for the build status
[08:15:26.752] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:26.752] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:175:0) after 1m0s
[08:16:26.803] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:175:0)
[08:16:26.803] Timer tick, asking Buildbucket for the build status
[08:16:26.991] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:26.991] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:176:0) after 1m0s
[08:17:27.040] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:176:0)
[08:17:27.040] Timer tick, asking Buildbucket for the build status
[08:17:27.184] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:27.184] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:177:0) after 1m0s
[08:18:27.214] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:177:0)
[08:18:27.214] Timer tick, asking Buildbucket for the build status
[08:18:27.540] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:27.540] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:178:0) after 1m0s
[08:19:27.648] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:178:0)
[08:19:27.648] Timer tick, asking Buildbucket for the build status
[08:19:27.831] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:27.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:179:0) after 1m0s
[08:20:28.224] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:179:0)
[08:20:28.224] Timer tick, asking Buildbucket for the build status
[08:20:28.675] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:28.675] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:180:0) after 1m0s
[08:21:28.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:180:0)
[08:21:28.864] Timer tick, asking Buildbucket for the build status
[08:21:29.061] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:29.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:181:0) after 1m0s
[08:22:29.391] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:181:0)
[08:22:29.391] Timer tick, asking Buildbucket for the build status
[08:22:30.003] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:30.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:182:0) after 1m0s
[08:23:30.164] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:182:0)
[08:23:30.164] Timer tick, asking Buildbucket for the build status
[08:23:30.365] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:30.365] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:183:0) after 1m0s
[08:24:30.501] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:183:0)
[08:24:30.501] Timer tick, asking Buildbucket for the build status
[08:24:30.785] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:30.785] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:184:0) after 1m0s
[08:25:30.811] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:184:0)
[08:25:30.811] Timer tick, asking Buildbucket for the build status
[08:25:31.183] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.183] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:185:0) after 1m0s
[08:26:31.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:185:0)
[08:26:31.387] Timer tick, asking Buildbucket for the build status
[08:26:31.624] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:186:0) after 1m0s
[08:27:31.753] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:186:0)
[08:27:31.753] Timer tick, asking Buildbucket for the build status
[08:27:31.924] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:31.924] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:187:0) after 1m0s
[08:28:35.534] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:187:0)
[08:28:35.534] Timer tick, asking Buildbucket for the build status
[08:28:35.851] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:35.851] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:188:0) after 1m0s
[08:29:35.928] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:188:0)
[08:29:35.928] Timer tick, asking Buildbucket for the build status
[08:29:36.094] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:36.094] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:189:0) after 1m0s
[08:30:36.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:189:0)
[08:30:36.105] Timer tick, asking Buildbucket for the build status
[08:30:36.430] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:36.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:190:0) after 1m0s
[08:31:36.529] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:190:0)
[08:31:36.529] Timer tick, asking Buildbucket for the build status
[08:31:36.721] Build 8893397624738619184: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:36.721] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9058827686875737872:191:0) after 1m0s
[08:32:30.429] Received PubSub notification, asking Buildbucket for the build status
[08:32:30.570] Build 8893397624738619184: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:32:30.570] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577003549587314",
"created_by": "project:chromium",
"created_ts": "1576992121906077",
"id": "8893397624738619184",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e57c38a8e6ee1a469694c210681ae456adbb1bc5\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$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-6o2q\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15511, \"got_angle_revision\": \"07d3bcf1c443bc3dc1d3d47d9daf20475a74771d\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"e57c38a8e6ee1a469694c210681ae456adbb1bc5\", \"got_revision_cp\": \"refs/heads/master@{#727079}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"6e3a387c01598240a7a8722ab8cbd1015ec1cd0a\", \"got_v8_revision\": \"3b4586216b8e96a98bd46c76068caadd744956d0\", \"got_v8_revision_cp\": \"refs/heads/8.1.69@{#1}\", \"got_webrtc_revision\": \"23df143850f9b6757de71805ce53d738d57f72c6\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30119}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e57c38a8e6ee1a469694c210681ae456adbb1bc5\"}, \"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-6o2q\"], \"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\": [\"4733-6bd8c41\"], \"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": "1576992125345695",
"status": "COMPLETED",
"status_changed_ts": "1577003549902802",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15511",
"builder:Windows deterministic",
"buildset:commit/git/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e57c38a8e6ee1a469694c210681ae456adbb1bc5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058827686875737872",
"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/8893397624738619184/+/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:4944dfaf0b437410",
"user_agent:luci-scheduler"
],
"updated_ts": "1577003549906316",
"url": "https://ci.chromium.org/b/8893397624738619184",
"utcnow_ts": "1577003550562469"
}
}
[08:32:30.570] Invocation finished in 3h10m30.085876301s with status SUCCEEDED