[20:12:34.142] New invocation is queued and will start shortly
[20:12:35.182] Starting the invocation (attempt 1)
[20:12:35.219] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:12:35.219] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:12:35.219] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9080696123514919424",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"be290504b82719290ad6a3fa91e5fba78b2ce792\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9080696123514919424",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/be290504b82719290ad6a3fa91e5fba78b2ce792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be290504b82719290ad6a3fa91e5fba78b2ce792",
"gitiles_ref:refs/heads/master"
]
}
[20:12:36.787] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1556136755363577",
"id": "8915266061566616048",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"be290504b82719290ad6a3fa91e5fba78b2ce792\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1556136756677411",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13053",
"builder:Windows deterministic",
"buildset:commit/git/be290504b82719290ad6a3fa91e5fba78b2ce792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be290504b82719290ad6a3fa91e5fba78b2ce792",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080696123514919424",
"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/8915266061566616048/+/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": "1556136756677518",
"url": "https://ci.chromium.org/b/8915266061566616048",
"utcnow_ts": "1556136756773284"
}
}
[20:12:36.787] Task URL: https://ci.chromium.org/b/8915266061566616048
[20:12:36.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:2:0) after 1m0s
[20:13:36.813] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:2:0)
[20:13:36.813] Timer tick, asking Buildbucket for the build status
[20:13:37.107] Build 8915266061566616048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:13:37.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:3:0) after 1m0s
[20:14:37.132] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:3:0)
[20:14:37.132] Timer tick, asking Buildbucket for the build status
[20:14:37.569] Build 8915266061566616048: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[20:14:37.569] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:4:0) after 1m0s
[20:15:01.350] Received PubSub notification, asking Buildbucket for the build status
[20:15:06.691] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:37.545] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:4:0)
[20:15:37.545] Timer tick, asking Buildbucket for the build status
[20:15:37.643] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:37.643] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:6:0) after 1m0s
[20:16:37.667] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:6:0)
[20:16:37.667] Timer tick, asking Buildbucket for the build status
[20:16:38.093] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:38.093] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:7:0) after 1m0s
[20:17:38.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:7:0)
[20:17:38.092] Timer tick, asking Buildbucket for the build status
[20:17:38.290] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:38.290] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:8:0) after 1m0s
[20:18:38.285] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:8:0)
[20:18:38.285] Timer tick, asking Buildbucket for the build status
[20:18:38.377] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:38.377] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:9:0) after 1m0s
[20:19:38.402] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:9:0)
[20:19:38.402] Timer tick, asking Buildbucket for the build status
[20:19:38.505] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:38.505] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:10:0) after 1m0s
[20:20:38.533] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:10:0)
[20:20:38.533] Timer tick, asking Buildbucket for the build status
[20:20:38.705] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:38.705] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:11:0) after 1m0s
[20:21:38.722] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:11:0)
[20:21:38.722] Timer tick, asking Buildbucket for the build status
[20:21:39.060] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:39.060] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:12:0) after 1m0s
[20:22:39.081] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:12:0)
[20:22:39.081] Timer tick, asking Buildbucket for the build status
[20:22:39.175] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:39.175] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:13:0) after 1m0s
[20:23:39.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:13:0)
[20:23:39.197] Timer tick, asking Buildbucket for the build status
[20:23:39.332] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:39.332] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:14:0) after 1m0s
[20:24:39.369] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:14:0)
[20:24:39.369] Timer tick, asking Buildbucket for the build status
[20:24:39.624] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:39.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:15:0) after 1m0s
[20:25:39.646] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:15:0)
[20:25:39.646] Timer tick, asking Buildbucket for the build status
[20:25:40.069] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:40.069] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:16:0) after 1m0s
[20:26:40.105] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:16:0)
[20:26:40.105] Timer tick, asking Buildbucket for the build status
[20:26:40.442] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:40.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:17:0) after 1m0s
[20:27:40.425] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:17:0)
[20:27:40.425] Timer tick, asking Buildbucket for the build status
[20:27:40.574] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:40.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:18:0) after 1m0s
[20:28:40.724] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:18:0)
[20:28:40.724] Timer tick, asking Buildbucket for the build status
[20:28:40.872] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:40.872] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:19:0) after 1m0s
[20:29:40.944] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:19:0)
[20:29:40.944] Timer tick, asking Buildbucket for the build status
[20:29:41.036] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:41.036] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:20:0) after 1m0s
[20:30:41.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:20:0)
[20:30:41.032] Timer tick, asking Buildbucket for the build status
[20:30:41.491] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:41.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:21:0) after 1m0s
[20:31:41.515] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:21:0)
[20:31:41.515] Timer tick, asking Buildbucket for the build status
[20:31:41.967] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:41.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:22:0) after 1m0s
[20:32:41.979] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:22:0)
[20:32:41.979] Timer tick, asking Buildbucket for the build status
[20:32:42.125] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:42.125] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:23:0) after 1m0s
[20:33:42.175] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:23:0)
[20:33:42.175] Timer tick, asking Buildbucket for the build status
[20:33:42.799] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:42.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:24:0) after 1m0s
[20:34:42.772] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:24:0)
[20:34:42.772] Timer tick, asking Buildbucket for the build status
[20:34:43.052] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:43.052] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:25:0) after 1m0s
[20:35:43.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:25:0)
[20:35:43.075] Timer tick, asking Buildbucket for the build status
[20:35:43.254] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:43.254] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:26:0) after 1m0s
[20:36:43.307] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:26:0)
[20:36:43.307] Timer tick, asking Buildbucket for the build status
[20:36:43.533] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:43.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:27:0) after 1m0s
[20:37:43.603] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:27:0)
[20:37:43.603] Timer tick, asking Buildbucket for the build status
[20:37:44.045] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:44.045] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:28:0) after 1m0s
[20:38:44.071] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:28:0)
[20:38:44.071] Timer tick, asking Buildbucket for the build status
[20:38:44.277] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:44.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:29:0) after 1m0s
[20:39:44.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:29:0)
[20:39:44.281] Timer tick, asking Buildbucket for the build status
[20:39:44.396] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:44.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:30:0) after 1m0s
[20:40:44.420] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:30:0)
[20:40:44.420] Timer tick, asking Buildbucket for the build status
[20:40:44.671] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:44.671] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:31:0) after 1m0s
[20:41:44.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:31:0)
[20:41:44.702] Timer tick, asking Buildbucket for the build status
[20:41:45.409] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:45.409] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:32:0) after 1m0s
[20:42:45.390] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:32:0)
[20:42:45.390] Timer tick, asking Buildbucket for the build status
[20:42:45.777] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:45.777] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:33:0) after 1m0s
[20:43:45.848] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:33:0)
[20:43:45.848] Timer tick, asking Buildbucket for the build status
[20:43:45.937] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:45.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:34:0) after 1m0s
[20:44:45.961] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:34:0)
[20:44:45.961] Timer tick, asking Buildbucket for the build status
[20:44:46.322] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:46.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:35:0) after 1m0s
[20:45:46.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:35:0)
[20:45:46.350] Timer tick, asking Buildbucket for the build status
[20:45:46.483] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:46.483] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:36:0) after 1m0s
[20:46:46.470] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:36:0)
[20:46:46.470] Timer tick, asking Buildbucket for the build status
[20:46:46.884] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:46.884] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:37:0) after 1m0s
[20:47:46.919] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:37:0)
[20:47:46.919] Timer tick, asking Buildbucket for the build status
[20:47:47.042] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:47.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:38:0) after 1m0s
[20:48:47.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:38:0)
[20:48:47.067] Timer tick, asking Buildbucket for the build status
[20:48:47.379] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:47.379] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:39:0) after 1m0s
[20:49:47.424] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:39:0)
[20:49:47.424] Timer tick, asking Buildbucket for the build status
[20:49:47.557] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:47.557] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:40:0) after 1m0s
[20:50:50.825] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:40:0)
[20:50:50.825] Timer tick, asking Buildbucket for the build status
[20:50:50.938] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:50.938] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:41:0) after 1m0s
[20:51:51.525] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:41:0)
[20:51:51.525] Timer tick, asking Buildbucket for the build status
[20:51:51.640] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:51.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:42:0) after 1m0s
[20:52:51.626] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:42:0)
[20:52:51.626] Timer tick, asking Buildbucket for the build status
[20:52:51.718] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:51.718] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:43:0) after 1m0s
[20:53:51.707] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:43:0)
[20:53:51.707] Timer tick, asking Buildbucket for the build status
[20:53:52.385] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:52.385] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:44:0) after 1m0s
[20:54:52.380] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:44:0)
[20:54:52.380] Timer tick, asking Buildbucket for the build status
[20:54:53.029] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:53.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:45:0) after 1m0s
[20:55:53.051] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:45:0)
[20:55:53.051] Timer tick, asking Buildbucket for the build status
[20:55:53.312] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:53.312] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:46:0) after 1m0s
[20:56:53.337] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:46:0)
[20:56:53.337] Timer tick, asking Buildbucket for the build status
[20:56:53.718] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:53.719] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:47:0) after 1m0s
[20:57:53.744] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:47:0)
[20:57:53.744] Timer tick, asking Buildbucket for the build status
[20:57:54.191] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:54.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:48:0) after 1m0s
[20:58:54.230] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:48:0)
[20:58:54.230] Timer tick, asking Buildbucket for the build status
[20:58:54.317] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:54.317] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:49:0) after 1m0s
[20:59:54.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:49:0)
[20:59:54.350] Timer tick, asking Buildbucket for the build status
[20:59:54.512] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:54.512] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:50:0) after 1m0s
[21:00:54.559] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:50:0)
[21:00:54.559] Timer tick, asking Buildbucket for the build status
[21:00:54.771] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:54.771] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:51:0) after 1m0s
[21:01:54.797] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:51:0)
[21:01:54.797] Timer tick, asking Buildbucket for the build status
[21:01:55.018] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:55.018] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:52:0) after 1m0s
[21:02:55.087] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:52:0)
[21:02:55.087] Timer tick, asking Buildbucket for the build status
[21:02:55.193] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:55.194] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:53:0) after 1m0s
[21:03:55.218] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:53:0)
[21:03:55.219] Timer tick, asking Buildbucket for the build status
[21:03:55.589] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:55.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:54:0) after 1m0s
[21:04:55.585] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:54:0)
[21:04:55.585] Timer tick, asking Buildbucket for the build status
[21:04:56.067] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:56.067] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:55:0) after 1m0s
[21:05:56.049] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:55:0)
[21:05:56.049] Timer tick, asking Buildbucket for the build status
[21:05:56.144] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:56.144] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:56:0) after 1m0s
[21:06:56.149] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:56:0)
[21:06:56.149] Timer tick, asking Buildbucket for the build status
[21:06:56.278] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:56.278] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:57:0) after 1m0s
[21:07:56.325] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:57:0)
[21:07:56.325] Timer tick, asking Buildbucket for the build status
[21:07:56.471] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:56.471] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:58:0) after 1m0s
[21:08:56.510] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:58:0)
[21:08:56.510] Timer tick, asking Buildbucket for the build status
[21:08:56.619] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:56.619] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:59:0) after 1m0s
[21:09:56.664] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:59:0)
[21:09:56.664] Timer tick, asking Buildbucket for the build status
[21:09:57.391] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:57.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:60:0) after 1m0s
[21:10:57.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:60:0)
[21:10:57.398] Timer tick, asking Buildbucket for the build status
[21:10:57.787] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:57.787] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:61:0) after 1m0s
[21:11:57.827] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:61:0)
[21:11:57.827] Timer tick, asking Buildbucket for the build status
[21:11:57.959] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:57.959] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:62:0) after 1m0s
[21:12:57.938] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:62:0)
[21:12:57.938] Timer tick, asking Buildbucket for the build status
[21:12:59.882] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:59.882] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:63:0) after 1m0s
[21:13:59.870] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:63:0)
[21:13:59.870] Timer tick, asking Buildbucket for the build status
[21:14:00.273] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:00.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:64:0) after 1m0s
[21:15:00.282] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:64:0)
[21:15:00.282] Timer tick, asking Buildbucket for the build status
[21:15:00.369] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:00.369] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:65:0) after 1m0s
[21:16:00.392] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:65:0)
[21:16:00.392] Timer tick, asking Buildbucket for the build status
[21:16:00.480] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:00.480] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:66:0) after 1m0s
[21:17:00.476] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:66:0)
[21:17:00.476] Timer tick, asking Buildbucket for the build status
[21:17:00.653] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:00.653] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:67:0) after 1m0s
[21:18:00.802] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:67:0)
[21:18:00.802] Timer tick, asking Buildbucket for the build status
[21:18:01.135] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:01.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:68:0) after 1m0s
[21:19:01.174] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:68:0)
[21:19:01.174] Timer tick, asking Buildbucket for the build status
[21:19:01.998] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:01.998] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:69:0) after 1m0s
[21:20:02.032] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:69:0)
[21:20:02.032] Timer tick, asking Buildbucket for the build status
[21:20:03.154] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:03.154] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:70:0) after 1m0s
[21:21:03.176] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:70:0)
[21:21:03.176] Timer tick, asking Buildbucket for the build status
[21:21:03.582] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:03.582] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:71:0) after 1m0s
[21:22:03.581] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:71:0)
[21:22:03.581] Timer tick, asking Buildbucket for the build status
[21:22:04.233] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:04.233] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:72:0) after 1m0s
[21:23:04.226] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:72:0)
[21:23:04.226] Timer tick, asking Buildbucket for the build status
[21:23:04.760] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:04.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:73:0) after 1m0s
[21:24:04.754] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:73:0)
[21:24:04.754] Timer tick, asking Buildbucket for the build status
[21:24:05.048] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:05.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:74:0) after 1m0s
[21:25:05.079] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:74:0)
[21:25:05.079] Timer tick, asking Buildbucket for the build status
[21:25:05.707] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:05.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:75:0) after 1m0s
[21:26:05.698] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:75:0)
[21:26:05.698] Timer tick, asking Buildbucket for the build status
[21:26:06.117] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:06.117] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:76:0) after 1m0s
[21:27:06.128] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:76:0)
[21:27:06.128] Timer tick, asking Buildbucket for the build status
[21:27:06.453] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:06.453] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:77:0) after 1m0s
[21:28:06.710] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:77:0)
[21:28:06.710] Timer tick, asking Buildbucket for the build status
[21:28:06.843] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:06.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:78:0) after 1m0s
[21:29:06.846] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:78:0)
[21:29:06.846] Timer tick, asking Buildbucket for the build status
[21:29:06.988] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:06.988] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:79:0) after 1m0s
[21:30:07.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:79:0)
[21:30:07.038] Timer tick, asking Buildbucket for the build status
[21:30:08.008] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:08.008] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:80:0) after 1m0s
[21:31:08.039] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:80:0)
[21:31:08.039] Timer tick, asking Buildbucket for the build status
[21:31:08.322] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:08.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:81:0) after 1m0s
[21:32:08.344] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:81:0)
[21:32:08.344] Timer tick, asking Buildbucket for the build status
[21:32:08.431] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:08.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:82:0) after 1m0s
[21:33:08.463] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:82:0)
[21:33:08.463] Timer tick, asking Buildbucket for the build status
[21:33:08.670] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:08.670] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:83:0) after 1m0s
[21:34:08.693] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:83:0)
[21:34:08.693] Timer tick, asking Buildbucket for the build status
[21:34:09.303] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:09.304] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:84:0) after 1m0s
[21:35:09.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:84:0)
[21:35:09.327] Timer tick, asking Buildbucket for the build status
[21:35:09.780] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:09.780] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:85:0) after 1m0s
[21:36:09.800] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:85:0)
[21:36:09.800] Timer tick, asking Buildbucket for the build status
[21:36:09.921] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:09.921] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:86:0) after 1m0s
[21:37:09.945] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:86:0)
[21:37:09.945] Timer tick, asking Buildbucket for the build status
[21:37:10.053] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:10.053] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:87:0) after 1m0s
[21:38:10.043] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:87:0)
[21:38:10.043] Timer tick, asking Buildbucket for the build status
[21:38:10.138] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:10.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:88:0) after 1m0s
[21:39:10.168] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:88:0)
[21:39:10.168] Timer tick, asking Buildbucket for the build status
[21:39:10.622] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:10.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:89:0) after 1m0s
[21:40:10.638] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:89:0)
[21:40:10.638] Timer tick, asking Buildbucket for the build status
[21:40:11.068] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:11.068] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:90:0) after 1m0s
[21:41:11.104] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:90:0)
[21:41:11.104] Timer tick, asking Buildbucket for the build status
[21:41:11.277] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:11.277] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:91:0) after 1m0s
[21:42:11.305] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:91:0)
[21:42:11.305] Timer tick, asking Buildbucket for the build status
[21:42:12.654] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:12.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:92:0) after 1m0s
[21:43:12.701] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:92:0)
[21:43:12.701] Timer tick, asking Buildbucket for the build status
[21:43:13.122] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:13.122] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:93:0) after 1m0s
[21:44:13.129] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:93:0)
[21:44:13.129] Timer tick, asking Buildbucket for the build status
[21:44:13.430] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:13.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:94:0) after 1m0s
[21:45:13.456] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:94:0)
[21:45:13.456] Timer tick, asking Buildbucket for the build status
[21:45:13.759] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:13.759] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:95:0) after 1m0s
[21:46:13.781] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:95:0)
[21:46:13.781] Timer tick, asking Buildbucket for the build status
[21:46:14.268] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:14.268] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:96:0) after 1m0s
[21:47:14.295] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:96:0)
[21:47:14.295] Timer tick, asking Buildbucket for the build status
[21:47:14.439] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:14.439] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:97:0) after 1m0s
[21:48:14.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:97:0)
[21:48:14.475] Timer tick, asking Buildbucket for the build status
[21:48:15.003] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:15.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:98:0) after 1m0s
[21:49:15.029] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:98:0)
[21:49:15.029] Timer tick, asking Buildbucket for the build status
[21:49:15.261] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:99:0) after 1m0s
[21:50:15.245] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:99:0)
[21:50:15.245] Timer tick, asking Buildbucket for the build status
[21:50:15.370] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:15.370] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:100:0) after 1m0s
[21:51:15.350] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:100:0)
[21:51:15.350] Timer tick, asking Buildbucket for the build status
[21:51:15.539] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:15.539] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:101:0) after 1m0s
[21:52:15.568] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:101:0)
[21:52:15.568] Timer tick, asking Buildbucket for the build status
[21:52:15.703] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:15.703] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:102:0) after 1m0s
[21:53:15.721] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:102:0)
[21:53:15.721] Timer tick, asking Buildbucket for the build status
[21:53:15.833] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:15.834] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:103:0) after 1m0s
[21:54:15.868] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:103:0)
[21:54:15.868] Timer tick, asking Buildbucket for the build status
[21:54:16.411] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:16.411] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:104:0) after 1m0s
[21:55:16.514] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:104:0)
[21:55:16.514] Timer tick, asking Buildbucket for the build status
[21:55:17.079] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:17.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:105:0) after 1m0s
[21:56:17.106] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:105:0)
[21:56:17.106] Timer tick, asking Buildbucket for the build status
[21:56:17.193] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:17.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:106:0) after 1m0s
[21:57:17.228] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:106:0)
[21:57:17.228] Timer tick, asking Buildbucket for the build status
[21:57:17.321] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:17.321] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:107:0) after 1m0s
[21:58:17.347] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:107:0)
[21:58:17.348] Timer tick, asking Buildbucket for the build status
[21:58:17.519] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:17.519] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:108:0) after 1m0s
[21:59:17.512] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:108:0)
[21:59:17.512] Timer tick, asking Buildbucket for the build status
[21:59:17.601] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:17.601] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:109:0) after 1m0s
[22:00:17.628] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:109:0)
[22:00:17.629] Timer tick, asking Buildbucket for the build status
[22:00:18.199] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:18.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:110:0) after 1m0s
[22:01:18.296] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:110:0)
[22:01:18.296] Timer tick, asking Buildbucket for the build status
[22:01:19.225] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.225] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:111:0) after 1m0s
[22:02:19.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:111:0)
[22:02:19.261] Timer tick, asking Buildbucket for the build status
[22:02:19.556] Build 8915266061566616048: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:19.556] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9080696123514919424:112:0) after 1m0s
[22:03:01.104] Received PubSub notification, asking Buildbucket for the build status
[22:03:01.252] Build 8915266061566616048: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:03:01.252] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "AUTO",
"completed_ts": "1556143380281644",
"created_by": "project:chromium",
"created_ts": "1556136755363577",
"id": "8915266061566616048",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"be290504b82719290ad6a3fa91e5fba78b2ce792\"}}",
"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-z5tg\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 13053, \"got_angle_revision\": \"8cbd321cafa92ffbf0495e6d0aeb9e1a97940fee\", \"got_dawn_revision\": \"22cee9ae36b23a8908525d668ef4728a26c931c4\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"be290504b82719290ad6a3fa91e5fba78b2ce792\", \"got_revision_cp\": \"refs/heads/master@{#653721}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"7149a9ba93e9258bfeaa9cb9f08bae091eaee767\", \"got_v8_revision_cp\": \"refs/heads/7.6.24@{#1}\", \"got_webrtc_revision\": \"852bffb6063aa36814c89a58390581e59643f1fb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27678}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"be290504b82719290ad6a3fa91e5fba78b2ce792\"}, \"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-z5tg\"], \"image\": [\"chrome-win10-1703-2018-04-20-61acaf8983f\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4274-a0a5f8c\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1556136900540218",
"status": "COMPLETED",
"status_changed_ts": "1556143380710753",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/13053",
"builder:Windows deterministic",
"buildset:commit/git/be290504b82719290ad6a3fa91e5fba78b2ce792",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/be290504b82719290ad6a3fa91e5fba78b2ce792",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9080696123514919424",
"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/8915266061566616048/+/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:4469cc0e67389810",
"user_agent:luci-scheduler"
],
"updated_ts": "1556143380768075",
"url": "https://ci.chromium.org/b/8915266061566616048",
"utcnow_ts": "1556143381242593"
}
}
[22:03:01.252] Invocation finished in 1h50m27.130120578s with status SUCCEEDED