[01:07:01.034] New invocation is queued and will start shortly
[01:07:03.366] Starting the invocation (attempt 1)
[01:07:03.405] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:07:03.405] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:07:03.405] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9034835533434172736",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"73e3a2c2f00f407e5279c1d25ef2950214eb7071\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9034835533434172736",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"gitiles_ref:refs/heads/master"
]
}
[01:07:04.493] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1599872823526549",
"id": "8869405470156906208",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"73e3a2c2f00f407e5279c1d25ef2950214eb7071\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1599872824292588",
"tags": [
"build_address:luci.chromium.ci/win-official/563",
"builder:win-official",
"buildset:commit/git/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034835533434172736",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869405470156906208/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1599872824292709",
"url": "https://ci.chromium.org/b/8869405470156906208",
"utcnow_ts": "1599872824481544"
}
}
[01:07:04.493] Task URL: https://ci.chromium.org/b/8869405470156906208
[01:07:04.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:2:0) after 1m0s
[01:07:29.635] Received PubSub notification, asking Buildbucket for the build status
[01:07:30.102] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:2:0)
[01:08:04.569] Timer tick, asking Buildbucket for the build status
[01:08:04.654] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:04.654] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:4:0) after 1m0s
[01:09:04.820] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:4:0)
[01:09:04.820] Timer tick, asking Buildbucket for the build status
[01:09:04.885] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:04.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:5:0) after 1m0s
[01:10:05.028] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:5:0)
[01:10:05.028] Timer tick, asking Buildbucket for the build status
[01:10:05.117] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:05.117] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:6:0) after 1m0s
[01:11:05.244] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:6:0)
[01:11:05.244] Timer tick, asking Buildbucket for the build status
[01:11:05.328] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:05.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:7:0) after 1m0s
[01:12:05.472] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:7:0)
[01:12:05.472] Timer tick, asking Buildbucket for the build status
[01:12:05.596] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:05.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:8:0) after 1m0s
[01:13:05.733] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:8:0)
[01:13:05.733] Timer tick, asking Buildbucket for the build status
[01:13:06.187] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:06.187] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:9:0) after 1m0s
[01:14:06.286] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:9:0)
[01:14:06.286] Timer tick, asking Buildbucket for the build status
[01:14:06.494] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:06.494] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:10:0) after 1m0s
[01:15:06.574] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:10:0)
[01:15:06.574] Timer tick, asking Buildbucket for the build status
[01:15:06.647] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:06.647] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:11:0) after 1m0s
[01:16:06.698] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:11:0)
[01:16:06.698] Timer tick, asking Buildbucket for the build status
[01:16:06.822] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:06.822] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:12:0) after 1m0s
[01:17:06.850] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:12:0)
[01:17:06.850] Timer tick, asking Buildbucket for the build status
[01:17:07.077] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:07.077] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:13:0) after 1m0s
[01:18:07.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:13:0)
[01:18:07.159] Timer tick, asking Buildbucket for the build status
[01:18:07.540] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:07.540] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:14:0) after 1m0s
[01:19:07.597] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:14:0)
[01:19:07.597] Timer tick, asking Buildbucket for the build status
[01:19:07.690] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:07.690] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:15:0) after 1m0s
[01:20:07.723] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:15:0)
[01:20:07.723] Timer tick, asking Buildbucket for the build status
[01:20:07.912] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:07.912] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:16:0) after 1m0s
[01:21:07.947] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:16:0)
[01:21:07.947] Timer tick, asking Buildbucket for the build status
[01:21:08.015] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:08.015] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:17:0) after 1m0s
[01:22:08.042] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:17:0)
[01:22:08.042] Timer tick, asking Buildbucket for the build status
[01:22:08.175] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:22:08.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:18:0) after 1m0s
[01:23:08.233] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:18:0)
[01:23:08.233] Timer tick, asking Buildbucket for the build status
[01:23:08.356] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:08.356] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:19:0) after 1m0s
[01:24:08.610] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:19:0)
[01:24:08.610] Timer tick, asking Buildbucket for the build status
[01:24:08.692] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:08.692] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:20:0) after 1m0s
[01:25:08.767] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:20:0)
[01:25:08.767] Timer tick, asking Buildbucket for the build status
[01:25:08.951] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:08.951] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:21:0) after 1m0s
[01:26:08.986] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:21:0)
[01:26:08.986] Timer tick, asking Buildbucket for the build status
[01:26:09.229] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:09.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:22:0) after 1m0s
[01:27:09.345] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:22:0)
[01:27:09.345] Timer tick, asking Buildbucket for the build status
[01:27:09.450] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:09.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:23:0) after 1m0s
[01:28:09.568] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:23:0)
[01:28:09.568] Timer tick, asking Buildbucket for the build status
[01:28:09.921] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:09.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:24:0) after 1m0s
[01:29:09.979] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:24:0)
[01:29:09.979] Timer tick, asking Buildbucket for the build status
[01:29:10.092] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:10.092] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:25:0) after 1m0s
[01:30:10.154] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:25:0)
[01:30:10.154] Timer tick, asking Buildbucket for the build status
[01:30:10.608] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:10.608] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:26:0) after 1m0s
[01:31:10.700] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:26:0)
[01:31:10.700] Timer tick, asking Buildbucket for the build status
[01:31:11.008] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:11.008] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:27:0) after 1m0s
[01:32:11.083] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:27:0)
[01:32:11.083] Timer tick, asking Buildbucket for the build status
[01:32:11.309] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:11.309] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:28:0) after 1m0s
[01:33:11.333] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:28:0)
[01:33:11.333] Timer tick, asking Buildbucket for the build status
[01:33:11.435] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:11.435] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:29:0) after 1m0s
[01:34:11.675] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:29:0)
[01:34:11.675] Timer tick, asking Buildbucket for the build status
[01:34:11.738] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:11.738] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:30:0) after 1m0s
[01:35:11.877] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:30:0)
[01:35:11.877] Timer tick, asking Buildbucket for the build status
[01:35:13.114] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:13.114] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:31:0) after 1m0s
[01:36:13.188] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:31:0)
[01:36:13.188] Timer tick, asking Buildbucket for the build status
[01:36:13.267] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:13.267] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:32:0) after 1m0s
[01:37:13.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:32:0)
[01:37:13.522] Timer tick, asking Buildbucket for the build status
[01:37:13.632] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:13.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:33:0) after 1m0s
[01:38:13.769] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:33:0)
[01:38:13.769] Timer tick, asking Buildbucket for the build status
[01:38:14.128] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:14.128] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:34:0) after 1m0s
[01:39:14.128] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:34:0)
[01:39:14.128] Timer tick, asking Buildbucket for the build status
[01:39:14.238] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:14.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:35:0) after 1m0s
[01:40:14.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:35:0)
[01:40:14.267] Timer tick, asking Buildbucket for the build status
[01:40:14.411] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:14.411] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:36:0) after 1m0s
[01:41:14.435] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:36:0)
[01:41:14.435] Timer tick, asking Buildbucket for the build status
[01:41:14.500] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:14.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:37:0) after 1m0s
[01:42:14.629] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:37:0)
[01:42:14.629] Timer tick, asking Buildbucket for the build status
[01:42:14.776] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:14.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:38:0) after 1m0s
[01:43:14.835] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:38:0)
[01:43:14.835] Timer tick, asking Buildbucket for the build status
[01:43:14.891] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:14.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:39:0) after 1m0s
[01:44:15.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:39:0)
[01:44:15.112] Timer tick, asking Buildbucket for the build status
[01:44:15.172] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:15.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:40:0) after 1m0s
[01:45:15.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:40:0)
[01:45:15.254] Timer tick, asking Buildbucket for the build status
[01:45:15.476] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:15.476] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:41:0) after 1m0s
[01:46:15.538] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:41:0)
[01:46:15.538] Timer tick, asking Buildbucket for the build status
[01:46:15.663] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:15.663] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:42:0) after 1m0s
[01:47:15.760] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:42:0)
[01:47:15.760] Timer tick, asking Buildbucket for the build status
[01:47:15.922] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:15.922] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:43:0) after 1m0s
[01:48:15.980] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:43:0)
[01:48:15.980] Timer tick, asking Buildbucket for the build status
[01:48:16.046] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:16.046] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:44:0) after 1m0s
[01:49:16.115] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:44:0)
[01:49:16.115] Timer tick, asking Buildbucket for the build status
[01:49:16.176] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:16.176] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:45:0) after 1m0s
[01:50:16.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:45:0)
[01:50:16.211] Timer tick, asking Buildbucket for the build status
[01:50:17.986] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:17.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:46:0) after 1m0s
[01:51:18.032] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:46:0)
[01:51:18.032] Timer tick, asking Buildbucket for the build status
[01:51:18.189] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:18.189] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:47:0) after 1m0s
[01:52:18.254] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:47:0)
[01:52:18.254] Timer tick, asking Buildbucket for the build status
[01:52:18.382] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:18.382] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:48:0) after 1m0s
[01:53:18.441] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:48:0)
[01:53:18.441] Timer tick, asking Buildbucket for the build status
[01:53:18.515] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:18.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:49:0) after 1m0s
[01:54:18.584] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:49:0)
[01:54:18.584] Timer tick, asking Buildbucket for the build status
[01:54:18.893] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:18.893] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:50:0) after 1m0s
[01:55:19.031] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:50:0)
[01:55:19.031] Timer tick, asking Buildbucket for the build status
[01:55:19.121] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:19.122] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:51:0) after 1m0s
[01:56:19.218] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:51:0)
[01:56:19.218] Timer tick, asking Buildbucket for the build status
[01:56:19.546] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:19.546] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:52:0) after 1m0s
[01:57:19.636] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:52:0)
[01:57:19.636] Timer tick, asking Buildbucket for the build status
[01:57:19.907] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:19.907] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:53:0) after 1m0s
[01:58:19.996] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:53:0)
[01:58:19.996] Timer tick, asking Buildbucket for the build status
[01:58:20.053] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:20.053] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:54:0) after 1m0s
[01:59:20.222] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:54:0)
[01:59:20.222] Timer tick, asking Buildbucket for the build status
[01:59:20.295] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:20.295] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:55:0) after 1m0s
[02:00:22.181] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:55:0)
[02:00:22.181] Timer tick, asking Buildbucket for the build status
[02:00:22.249] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:22.249] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:56:0) after 1m0s
[02:01:22.524] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:56:0)
[02:01:22.524] Timer tick, asking Buildbucket for the build status
[02:01:22.596] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:22.596] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:57:0) after 1m0s
[02:02:22.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:57:0)
[02:02:22.921] Timer tick, asking Buildbucket for the build status
[02:02:23.085] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:23.085] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:58:0) after 1m0s
[02:03:23.139] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:58:0)
[02:03:23.139] Timer tick, asking Buildbucket for the build status
[02:03:23.288] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:23.288] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:59:0) after 1m0s
[02:04:23.350] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:59:0)
[02:04:23.350] Timer tick, asking Buildbucket for the build status
[02:04:23.401] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:23.401] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:60:0) after 1m0s
[02:05:23.633] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:60:0)
[02:05:23.633] Timer tick, asking Buildbucket for the build status
[02:05:24.398] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:24.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:61:0) after 1m0s
[02:06:24.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:61:0)
[02:06:24.498] Timer tick, asking Buildbucket for the build status
[02:06:24.612] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:24.612] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:62:0) after 1m0s
[02:07:24.672] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:62:0)
[02:07:24.672] Timer tick, asking Buildbucket for the build status
[02:07:24.840] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:24.840] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:63:0) after 1m0s
[02:08:24.907] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:63:0)
[02:08:24.907] Timer tick, asking Buildbucket for the build status
[02:08:35.347] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:35.347] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:64:0) after 1m0s
[02:09:35.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:64:0)
[02:09:35.440] Timer tick, asking Buildbucket for the build status
[02:09:35.615] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:35.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:65:0) after 1m0s
[02:10:35.652] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:65:0)
[02:10:35.652] Timer tick, asking Buildbucket for the build status
[02:10:35.828] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:35.828] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:66:0) after 1m0s
[02:11:35.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:66:0)
[02:11:35.856] Timer tick, asking Buildbucket for the build status
[02:11:35.921] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:35.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:67:0) after 1m0s
[02:12:35.962] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:67:0)
[02:12:35.962] Timer tick, asking Buildbucket for the build status
[02:12:36.063] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:36.063] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:68:0) after 1m0s
[02:13:36.217] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:68:0)
[02:13:36.217] Timer tick, asking Buildbucket for the build status
[02:13:36.515] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:36.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:69:0) after 1m0s
[02:14:36.593] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:69:0)
[02:14:36.593] Timer tick, asking Buildbucket for the build status
[02:14:36.656] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:36.656] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:70:0) after 1m0s
[02:15:36.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:70:0)
[02:15:36.798] Timer tick, asking Buildbucket for the build status
[02:15:37.028] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:37.028] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:71:0) after 1m0s
[02:16:37.090] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:71:0)
[02:16:37.090] Timer tick, asking Buildbucket for the build status
[02:16:37.199] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:37.199] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:72:0) after 1m0s
[02:17:37.260] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:72:0)
[02:17:37.260] Timer tick, asking Buildbucket for the build status
[02:17:37.636] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:37.636] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:73:0) after 1m0s
[02:18:37.654] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:73:0)
[02:18:37.654] Timer tick, asking Buildbucket for the build status
[02:18:37.730] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:37.730] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:74:0) after 1m0s
[02:19:37.784] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:74:0)
[02:19:37.784] Timer tick, asking Buildbucket for the build status
[02:19:37.879] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:37.879] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:75:0) after 1m0s
[02:20:37.909] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:75:0)
[02:20:37.909] Timer tick, asking Buildbucket for the build status
[02:20:37.989] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:37.989] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:76:0) after 1m0s
[02:21:38.015] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:76:0)
[02:21:38.015] Timer tick, asking Buildbucket for the build status
[02:21:38.255] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:38.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:77:0) after 1m0s
[02:22:38.310] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:77:0)
[02:22:38.310] Timer tick, asking Buildbucket for the build status
[02:22:38.996] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:38.996] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:78:0) after 1m0s
[02:23:39.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:78:0)
[02:23:39.132] Timer tick, asking Buildbucket for the build status
[02:23:39.301] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:39.301] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:79:0) after 1m0s
[02:24:39.375] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:79:0)
[02:24:39.375] Timer tick, asking Buildbucket for the build status
[02:24:39.466] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:39.466] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:80:0) after 1m0s
[02:25:39.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:80:0)
[02:25:39.495] Timer tick, asking Buildbucket for the build status
[02:25:39.601] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:39.601] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:81:0) after 1m0s
[02:26:39.625] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:81:0)
[02:26:39.625] Timer tick, asking Buildbucket for the build status
[02:26:39.752] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:39.752] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:82:0) after 1m0s
[02:27:39.887] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:82:0)
[02:27:39.887] Timer tick, asking Buildbucket for the build status
[02:27:40.221] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:40.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:83:0) after 1m0s
[02:28:40.283] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:83:0)
[02:28:40.283] Timer tick, asking Buildbucket for the build status
[02:28:40.369] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:40.369] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:84:0) after 1m0s
[02:29:40.475] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:84:0)
[02:29:40.475] Timer tick, asking Buildbucket for the build status
[02:29:40.556] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:40.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:85:0) after 1m0s
[02:30:40.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:85:0)
[02:30:40.711] Timer tick, asking Buildbucket for the build status
[02:30:40.786] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:40.786] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:86:0) after 1m0s
[02:31:40.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:86:0)
[02:31:40.857] Timer tick, asking Buildbucket for the build status
[02:31:41.021] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:41.021] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:87:0) after 1m0s
[02:32:41.085] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:87:0)
[02:32:41.085] Timer tick, asking Buildbucket for the build status
[02:32:41.198] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:41.198] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:88:0) after 1m0s
[02:33:41.402] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:88:0)
[02:33:41.402] Timer tick, asking Buildbucket for the build status
[02:33:41.482] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:41.482] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:89:0) after 1m0s
[02:34:41.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:89:0)
[02:34:41.680] Timer tick, asking Buildbucket for the build status
[02:34:41.941] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:41.941] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:90:0) after 1m0s
[02:35:42.088] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:90:0)
[02:35:42.088] Timer tick, asking Buildbucket for the build status
[02:35:42.159] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:42.159] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:91:0) after 1m0s
[02:36:42.267] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:91:0)
[02:36:42.267] Timer tick, asking Buildbucket for the build status
[02:36:42.338] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:42.338] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:92:0) after 1m0s
[02:37:42.498] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:92:0)
[02:37:42.498] Timer tick, asking Buildbucket for the build status
[02:37:42.621] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:42.621] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:93:0) after 1m0s
[02:38:42.639] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:93:0)
[02:38:42.639] Timer tick, asking Buildbucket for the build status
[02:38:42.808] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:42.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:94:0) after 1m0s
[02:39:42.791] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:94:0)
[02:39:42.791] Timer tick, asking Buildbucket for the build status
[02:39:42.869] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:42.869] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:95:0) after 1m0s
[02:40:42.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:95:0)
[02:40:42.900] Timer tick, asking Buildbucket for the build status
[02:40:43.101] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:43.101] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:96:0) after 1m0s
[02:41:43.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:96:0)
[02:41:43.137] Timer tick, asking Buildbucket for the build status
[02:41:43.223] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:43.224] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:97:0) after 1m0s
[02:42:43.301] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:97:0)
[02:42:43.301] Timer tick, asking Buildbucket for the build status
[02:42:43.408] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:43.408] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:98:0) after 1m0s
[02:43:43.452] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:98:0)
[02:43:43.452] Timer tick, asking Buildbucket for the build status
[02:43:43.521] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:43.521] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:99:0) after 1m0s
[02:44:43.586] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:99:0)
[02:44:43.586] Timer tick, asking Buildbucket for the build status
[02:44:43.653] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:43.653] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:100:0) after 1m0s
[02:45:43.686] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:100:0)
[02:45:43.686] Timer tick, asking Buildbucket for the build status
[02:45:43.775] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:43.775] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:101:0) after 1m0s
[02:46:43.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:101:0)
[02:46:43.847] Timer tick, asking Buildbucket for the build status
[02:46:43.983] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:43.983] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:102:0) after 1m0s
[02:47:44.017] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:102:0)
[02:47:44.017] Timer tick, asking Buildbucket for the build status
[02:47:44.196] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:44.196] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:103:0) after 1m0s
[02:48:44.279] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:103:0)
[02:48:44.279] Timer tick, asking Buildbucket for the build status
[02:48:44.493] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:44.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:104:0) after 1m0s
[02:49:44.570] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:104:0)
[02:49:44.570] Timer tick, asking Buildbucket for the build status
[02:49:44.665] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:44.665] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:105:0) after 1m0s
[02:50:44.701] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:105:0)
[02:50:44.701] Timer tick, asking Buildbucket for the build status
[02:50:44.761] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:44.761] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:106:0) after 1m0s
[02:51:44.788] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:106:0)
[02:51:44.788] Timer tick, asking Buildbucket for the build status
[02:51:44.849] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:44.849] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:107:0) after 1m0s
[02:52:44.882] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:107:0)
[02:52:44.882] Timer tick, asking Buildbucket for the build status
[02:52:44.986] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:44.986] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:108:0) after 1m0s
[02:53:45.011] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:108:0)
[02:53:45.011] Timer tick, asking Buildbucket for the build status
[02:53:45.207] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:45.207] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:109:0) after 1m0s
[02:54:45.232] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:109:0)
[02:54:45.232] Timer tick, asking Buildbucket for the build status
[02:54:45.337] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:45.337] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:110:0) after 1m0s
[02:55:45.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:110:0)
[02:55:45.406] Timer tick, asking Buildbucket for the build status
[02:55:45.515] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:45.515] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:111:0) after 1m0s
[02:56:45.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:111:0)
[02:56:45.544] Timer tick, asking Buildbucket for the build status
[02:56:45.607] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:45.607] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:112:0) after 1m0s
[02:57:45.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:112:0)
[02:57:45.676] Timer tick, asking Buildbucket for the build status
[02:57:45.891] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.891] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:113:0) after 1m0s
[02:58:45.961] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:113:0)
[02:58:45.961] Timer tick, asking Buildbucket for the build status
[02:58:46.393] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:46.394] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:114:0) after 1m0s
[02:59:46.522] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:114:0)
[02:59:46.522] Timer tick, asking Buildbucket for the build status
[02:59:46.606] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:46.606] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:115:0) after 1m0s
[03:00:46.715] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:115:0)
[03:00:46.715] Timer tick, asking Buildbucket for the build status
[03:00:46.861] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:46.861] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:116:0) after 1m0s
[03:01:46.959] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:116:0)
[03:01:46.959] Timer tick, asking Buildbucket for the build status
[03:01:47.210] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:47.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:117:0) after 1m0s
[03:02:47.287] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:117:0)
[03:02:47.287] Timer tick, asking Buildbucket for the build status
[03:02:47.391] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:47.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:118:0) after 1m0s
[03:03:47.467] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:118:0)
[03:03:47.467] Timer tick, asking Buildbucket for the build status
[03:03:47.615] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:47.615] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:119:0) after 1m0s
[03:04:47.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:119:0)
[03:04:47.676] Timer tick, asking Buildbucket for the build status
[03:04:47.997] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:47.997] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:120:0) after 1m0s
[03:05:48.045] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:120:0)
[03:05:48.045] Timer tick, asking Buildbucket for the build status
[03:05:48.123] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:48.123] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:121:0) after 1m0s
[03:06:48.216] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:121:0)
[03:06:48.216] Timer tick, asking Buildbucket for the build status
[03:06:48.283] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:48.283] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:122:0) after 1m0s
[03:07:48.356] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:122:0)
[03:07:48.356] Timer tick, asking Buildbucket for the build status
[03:07:48.467] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.467] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:123:0) after 1m0s
[03:08:48.576] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:123:0)
[03:08:48.576] Timer tick, asking Buildbucket for the build status
[03:08:48.787] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.787] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:124:0) after 1m0s
[03:09:48.831] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:124:0)
[03:09:48.831] Timer tick, asking Buildbucket for the build status
[03:09:48.944] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.944] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:125:0) after 1m0s
[03:10:48.988] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:125:0)
[03:10:48.988] Timer tick, asking Buildbucket for the build status
[03:10:49.055] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:49.055] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:126:0) after 1m0s
[03:11:49.107] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:126:0)
[03:11:49.107] Timer tick, asking Buildbucket for the build status
[03:11:49.339] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:49.339] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:127:0) after 1m0s
[03:12:49.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:127:0)
[03:12:49.370] Timer tick, asking Buildbucket for the build status
[03:12:49.475] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.475] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:128:0) after 1m0s
[03:13:49.569] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:128:0)
[03:13:49.569] Timer tick, asking Buildbucket for the build status
[03:13:49.813] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:49.813] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:129:0) after 1m0s
[03:14:49.920] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:129:0)
[03:14:49.920] Timer tick, asking Buildbucket for the build status
[03:14:50.229] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:50.229] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:130:0) after 1m0s
[03:15:50.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:130:0)
[03:15:50.412] Timer tick, asking Buildbucket for the build status
[03:15:50.477] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:50.477] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:131:0) after 1m0s
[03:16:50.554] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:131:0)
[03:16:50.554] Timer tick, asking Buildbucket for the build status
[03:16:50.632] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:50.632] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:132:0) after 1m0s
[03:17:50.667] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:132:0)
[03:17:50.667] Timer tick, asking Buildbucket for the build status
[03:17:50.866] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:133:0) after 1m0s
[03:18:50.935] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:133:0)
[03:18:50.935] Timer tick, asking Buildbucket for the build status
[03:18:51.098] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:51.098] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:134:0) after 1m0s
[03:19:51.203] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:134:0)
[03:19:51.203] Timer tick, asking Buildbucket for the build status
[03:19:51.328] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:51.328] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:135:0) after 1m0s
[03:20:51.536] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:135:0)
[03:20:51.536] Timer tick, asking Buildbucket for the build status
[03:20:51.599] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:51.599] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:136:0) after 1m0s
[03:21:51.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:136:0)
[03:21:51.676] Timer tick, asking Buildbucket for the build status
[03:21:51.743] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:51.743] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:137:0) after 1m0s
[03:22:51.840] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:137:0)
[03:22:51.840] Timer tick, asking Buildbucket for the build status
[03:22:51.956] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:51.956] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:138:0) after 1m0s
[03:23:51.964] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:138:0)
[03:23:51.964] Timer tick, asking Buildbucket for the build status
[03:23:52.045] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:52.045] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:139:0) after 1m0s
[03:24:52.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:139:0)
[03:24:52.212] Timer tick, asking Buildbucket for the build status
[03:24:52.274] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:52.274] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:140:0) after 1m0s
[03:25:52.396] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:140:0)
[03:25:52.396] Timer tick, asking Buildbucket for the build status
[03:25:52.472] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:52.472] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:141:0) after 1m0s
[03:26:52.501] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:141:0)
[03:26:52.501] Timer tick, asking Buildbucket for the build status
[03:26:52.699] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:52.699] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:142:0) after 1m0s
[03:27:52.813] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:142:0)
[03:27:52.813] Timer tick, asking Buildbucket for the build status
[03:27:53.019] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:53.019] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:143:0) after 1m0s
[03:28:53.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:143:0)
[03:28:53.108] Timer tick, asking Buildbucket for the build status
[03:28:53.200] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:53.200] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:144:0) after 1m0s
[03:29:53.264] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:144:0)
[03:29:53.264] Timer tick, asking Buildbucket for the build status
[03:29:53.575] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:53.575] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:145:0) after 1m0s
[03:30:53.622] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:145:0)
[03:30:53.622] Timer tick, asking Buildbucket for the build status
[03:30:53.691] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:53.691] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:146:0) after 1m0s
[03:31:53.729] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:146:0)
[03:31:53.729] Timer tick, asking Buildbucket for the build status
[03:31:53.837] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.837] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:147:0) after 1m0s
[03:32:53.846] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:147:0)
[03:32:53.846] Timer tick, asking Buildbucket for the build status
[03:32:53.953] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:53.953] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:148:0) after 1m0s
[03:33:54.003] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:148:0)
[03:33:54.003] Timer tick, asking Buildbucket for the build status
[03:33:54.064] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:54.064] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:149:0) after 1m0s
[03:34:54.159] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:149:0)
[03:34:54.159] Timer tick, asking Buildbucket for the build status
[03:34:54.227] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:54.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:150:0) after 1m0s
[03:35:54.293] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:150:0)
[03:35:54.293] Timer tick, asking Buildbucket for the build status
[03:35:54.508] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:54.508] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:151:0) after 1m0s
[03:36:54.519] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:151:0)
[03:36:54.519] Timer tick, asking Buildbucket for the build status
[03:36:54.579] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:54.579] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:152:0) after 1m0s
[03:37:54.611] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:152:0)
[03:37:54.611] Timer tick, asking Buildbucket for the build status
[03:37:54.703] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:54.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:153:0) after 1m0s
[03:38:54.779] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:153:0)
[03:38:54.779] Timer tick, asking Buildbucket for the build status
[03:38:54.848] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:54.848] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:154:0) after 1m0s
[03:39:54.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:154:0)
[03:39:54.939] Timer tick, asking Buildbucket for the build status
[03:39:55.108] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:55.108] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:155:0) after 1m0s
[03:40:55.178] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:155:0)
[03:40:55.178] Timer tick, asking Buildbucket for the build status
[03:40:55.427] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:55.427] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:156:0) after 1m0s
[03:41:55.506] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:156:0)
[03:41:55.506] Timer tick, asking Buildbucket for the build status
[03:41:55.626] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:55.626] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:157:0) after 1m0s
[03:42:55.680] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:157:0)
[03:42:55.680] Timer tick, asking Buildbucket for the build status
[03:42:56.129] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:56.129] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:158:0) after 1m0s
[03:43:56.184] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:158:0)
[03:43:56.184] Timer tick, asking Buildbucket for the build status
[03:43:56.585] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:56.585] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:159:0) after 1m0s
[03:44:56.616] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:159:0)
[03:44:56.616] Timer tick, asking Buildbucket for the build status
[03:44:56.733] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:56.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:160:0) after 1m0s
[03:45:56.746] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:160:0)
[03:45:56.746] Timer tick, asking Buildbucket for the build status
[03:45:56.914] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:56.914] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:161:0) after 1m0s
[03:46:56.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:161:0)
[03:46:56.911] Timer tick, asking Buildbucket for the build status
[03:46:57.095] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:57.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:162:0) after 1m0s
[03:47:57.174] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:162:0)
[03:47:57.174] Timer tick, asking Buildbucket for the build status
[03:47:57.437] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:57.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:163:0) after 1m0s
[03:48:57.512] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:163:0)
[03:48:57.512] Timer tick, asking Buildbucket for the build status
[03:48:57.584] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:57.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:164:0) after 1m0s
[03:49:57.742] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:164:0)
[03:49:57.742] Timer tick, asking Buildbucket for the build status
[03:49:57.798] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:57.798] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:165:0) after 1m0s
[03:50:57.900] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:165:0)
[03:50:57.900] Timer tick, asking Buildbucket for the build status
[03:50:57.962] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:57.962] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:166:0) after 1m0s
[03:51:58.108] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:166:0)
[03:51:58.108] Timer tick, asking Buildbucket for the build status
[03:51:58.174] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:58.175] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:167:0) after 1m0s
[03:52:58.354] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:167:0)
[03:52:58.354] Timer tick, asking Buildbucket for the build status
[03:52:58.684] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:168:0) after 1m0s
[03:53:58.874] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:168:0)
[03:53:58.874] Timer tick, asking Buildbucket for the build status
[03:53:58.988] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:58.988] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:169:0) after 1m0s
[03:54:59.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:169:0)
[03:54:59.069] Timer tick, asking Buildbucket for the build status
[03:54:59.172] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:59.172] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:170:0) after 1m0s
[03:55:59.320] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:170:0)
[03:55:59.320] Timer tick, asking Buildbucket for the build status
[03:55:59.422] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:59.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:171:0) after 1m0s
[03:56:59.458] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:171:0)
[03:56:59.458] Timer tick, asking Buildbucket for the build status
[03:56:59.712] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:59.712] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:172:0) after 1m0s
[03:57:59.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:172:0)
[03:57:59.871] Timer tick, asking Buildbucket for the build status
[03:57:59.981] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:59.981] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:173:0) after 1m0s
[03:59:00.023] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:173:0)
[03:59:00.023] Timer tick, asking Buildbucket for the build status
[03:59:00.308] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:00.308] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:174:0) after 1m0s
[04:00:00.367] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:174:0)
[04:00:00.367] Timer tick, asking Buildbucket for the build status
[04:00:00.580] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:00.580] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:175:0) after 1m0s
[04:01:01.393] Handling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:175:0)
[04:01:01.393] Timer tick, asking Buildbucket for the build status
[04:01:01.898] Build 8869405470156906208: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:01.898] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9034835533434172736:176:0) after 1m0s
[04:01:22.958] Received PubSub notification, asking Buildbucket for the build status
[04:01:23.025] Build 8869405470156906208: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:01:23.025] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1599883281883945",
"created_by": "project:chromium",
"created_ts": "1599872823526549",
"id": "8869405470156906208",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"73e3a2c2f00f407e5279c1d25ef2950214eb7071\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"73e3a2c2f00f407e5279c1d25ef2950214eb7071\", \"project\": \"chromium/src\"}], \"$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\": \"win-dbg-4-kn46\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 563, \"got_angle_revision\": \"bca88739adb7e7bd82864ce620bc9c15c087c666\", \"got_dawn_revision\": \"dbd34449af20f2d026b1e7f959073e254066ec83\", \"got_nacl_revision\": \"3008f9e6de122325d8f9dbf02f7cdd51fa1ec306\", \"got_revision\": \"73e3a2c2f00f407e5279c1d25ef2950214eb7071\", \"got_revision_cp\": \"refs/heads/master@{#806415}\", \"got_swarming_client_revision\": \"4c095d04179dc725a300085ae21fe3b79900d072\", \"got_swiftshader_revision\": \"41974f57973ebcdab4cfde6cc60354f6b79a5901\", \"got_v8_revision\": \"bb4817544d7ce327fc432a8229efa213952ca979\", \"got_v8_revision_cp\": \"refs/heads/8.7.76@{#1}\", \"got_webrtc_revision\": \"32eb03a1fbe2007a055a227e317ffea4a6afaa55\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32087}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"73e3a2c2f00f407e5279c1d25ef2950214eb7071\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\", \"git\", \"goma_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-4-kn46\"], \"image\": [\"chrome-win10-1703-20083100-22dcea0839e\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5518-246c570\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1599872848483510",
"status": "COMPLETED",
"status_changed_ts": "1599883282467970",
"tags": [
"build_address:luci.chromium.ci/win-official/563",
"builder:win-official",
"buildset:commit/git/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/73e3a2c2f00f407e5279c1d25ef2950214eb7071",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9034835533434172736",
"scheduler_job_id:chromium/win-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8869405470156906208/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4e98ab7d46599c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1599883282511942",
"url": "https://ci.chromium.org/b/8869405470156906208",
"utcnow_ts": "1599883283018123"
}
}
[04:01:23.025] Invocation finished in 2h54m22.008671604s with status SUCCEEDED