[11:03:11.101] New invocation is queued and will start shortly
[11:03:12.571] Starting the invocation (attempt 1)
[11:03:12.626] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:03:12.641] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:03:12.641] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030539968385165712",
"parameters_json": "{\"builder_name\":\"win-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8e6168b866f984030d784123c1349ca1b3cc2f38\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win-official",
"scheduler_invocation_id:9030539968385165712",
"scheduler_job_id:chromium/win-official",
"user_agent:luci-scheduler",
"buildset:commit/git/8e6168b866f984030d784123c1349ca1b3cc2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6168b866f984030d784123c1349ca1b3cc2f38",
"gitiles_ref:refs/heads/master"
]
}
[11:03:13.638] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603969392836132",
"id": "8865109905896183696",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e6168b866f984030d784123c1349ca1b3cc2f38\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603969393421528",
"tags": [
"build_address:luci.chromium.ci/win-official/918",
"builder:win-official",
"buildset:commit/git/8e6168b866f984030d784123c1349ca1b3cc2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6168b866f984030d784123c1349ca1b3cc2f38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030539968385165712",
"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/8865109905896183696/+/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": "1603969393421856",
"url": "https://ci.chromium.org/b/8865109905896183696",
"utcnow_ts": "1603969393624000"
}
}
[11:03:13.638] Task URL: https://ci.chromium.org/b/8865109905896183696
[11:03:13.638] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:2:0) after 1m0s
[11:03:51.250] Received PubSub notification, asking Buildbucket for the build status
[11:03:51.322] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:13.716] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:2:0)
[11:04:13.716] Timer tick, asking Buildbucket for the build status
[11:04:13.884] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:13.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:4:0) after 1m0s
[11:05:14.014] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:4:0)
[11:05:14.014] Timer tick, asking Buildbucket for the build status
[11:05:14.279] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:14.279] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:5:0) after 1m0s
[11:06:14.252] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:5:0)
[11:06:14.252] Timer tick, asking Buildbucket for the build status
[11:06:14.324] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:14.324] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:6:0) after 1m0s
[11:07:14.352] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:6:0)
[11:07:14.353] Timer tick, asking Buildbucket for the build status
[11:07:14.443] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:14.443] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:7:0) after 1m0s
[11:08:14.468] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:7:0)
[11:08:14.468] Timer tick, asking Buildbucket for the build status
[11:08:14.688] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:14.688] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:8:0) after 1m0s
[11:09:14.805] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:8:0)
[11:09:14.805] Timer tick, asking Buildbucket for the build status
[11:09:15.591] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:15.591] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:9:0) after 1m0s
[11:10:15.819] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:9:0)
[11:10:15.819] Timer tick, asking Buildbucket for the build status
[11:10:15.919] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:15.919] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:10:0) after 1m0s
[11:11:16.065] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:10:0)
[11:11:16.065] Timer tick, asking Buildbucket for the build status
[11:11:16.158] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:16.158] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:11:0) after 1m0s
[11:12:16.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:11:0)
[11:12:16.243] Timer tick, asking Buildbucket for the build status
[11:12:16.330] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:16.330] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:12:0) after 1m0s
[11:13:16.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:12:0)
[11:13:16.344] Timer tick, asking Buildbucket for the build status
[11:13:16.506] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:16.506] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:13:0) after 1m0s
[11:14:16.529] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:13:0)
[11:14:16.529] Timer tick, asking Buildbucket for the build status
[11:14:16.655] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:16.655] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:14:0) after 1m0s
[11:15:16.731] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:14:0)
[11:15:16.731] Timer tick, asking Buildbucket for the build status
[11:15:16.808] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:16.808] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:15:0) after 1m0s
[11:16:16.821] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:15:0)
[11:16:16.821] Timer tick, asking Buildbucket for the build status
[11:16:16.904] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:16.904] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:16:0) after 1m0s
[11:17:17.044] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:16:0)
[11:17:17.044] Timer tick, asking Buildbucket for the build status
[11:17:17.354] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:17.354] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:17:0) after 1m0s
[11:18:17.412] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:17:0)
[11:18:17.412] Timer tick, asking Buildbucket for the build status
[11:18:17.577] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:17.577] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:18:0) after 1m0s
[11:19:17.601] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:18:0)
[11:19:17.601] Timer tick, asking Buildbucket for the build status
[11:19:17.796] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:17.797] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:19:0) after 1m0s
[11:20:17.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:19:0)
[11:20:17.943] Timer tick, asking Buildbucket for the build status
[11:20:18.010] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:18.010] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:20:0) after 1m0s
[11:21:17.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:20:0)
[11:21:17.997] Timer tick, asking Buildbucket for the build status
[11:21:18.365] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:18.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:21:0) after 1m0s
[11:22:18.422] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:21:0)
[11:22:18.422] Timer tick, asking Buildbucket for the build status
[11:22:18.583] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:18.583] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:22:0) after 1m0s
[11:23:18.676] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:22:0)
[11:23:18.676] Timer tick, asking Buildbucket for the build status
[11:23:18.800] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:18.800] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:23:0) after 1m0s
[11:24:18.863] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:23:0)
[11:24:18.863] Timer tick, asking Buildbucket for the build status
[11:24:18.987] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:18.987] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:24:0) after 1m0s
[11:25:19.040] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:24:0)
[11:25:19.040] Timer tick, asking Buildbucket for the build status
[11:25:19.164] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:19.164] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:25:0) after 1m0s
[11:26:19.340] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:25:0)
[11:26:19.340] Timer tick, asking Buildbucket for the build status
[11:26:19.419] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:19.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:26:0) after 1m0s
[11:27:19.515] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:26:0)
[11:27:19.515] Timer tick, asking Buildbucket for the build status
[11:27:19.682] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:19.682] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:27:0) after 1m0s
[11:28:19.730] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:27:0)
[11:28:19.730] Timer tick, asking Buildbucket for the build status
[11:28:19.842] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:19.842] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:28:0) after 1m0s
[11:29:19.886] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:28:0)
[11:29:19.886] Timer tick, asking Buildbucket for the build status
[11:29:19.961] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:19.961] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:29:0) after 1m0s
[11:30:19.987] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:29:0)
[11:30:19.987] Timer tick, asking Buildbucket for the build status
[11:30:20.094] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:20.094] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:30:0) after 1m0s
[11:31:20.253] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:30:0)
[11:31:20.253] Timer tick, asking Buildbucket for the build status
[11:31:20.332] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:20.332] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:31:0) after 1m0s
[11:32:20.423] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:31:0)
[11:32:20.423] Timer tick, asking Buildbucket for the build status
[11:32:20.489] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:20.489] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:32:0) after 1m0s
[11:33:20.662] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:32:0)
[11:33:20.662] Timer tick, asking Buildbucket for the build status
[11:33:20.816] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:20.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:33:0) after 1m0s
[11:34:20.893] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:33:0)
[11:34:20.893] Timer tick, asking Buildbucket for the build status
[11:34:20.968] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:20.968] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:34:0) after 1m0s
[11:35:21.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:34:0)
[11:35:21.053] Timer tick, asking Buildbucket for the build status
[11:35:21.167] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:21.167] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:35:0) after 1m0s
[11:36:21.240] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:35:0)
[11:36:21.240] Timer tick, asking Buildbucket for the build status
[11:36:21.402] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:21.402] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:36:0) after 1m0s
[11:37:21.481] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:36:0)
[11:37:21.481] Timer tick, asking Buildbucket for the build status
[11:37:21.605] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:21.605] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:37:0) after 1m0s
[11:38:21.694] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:37:0)
[11:38:21.694] Timer tick, asking Buildbucket for the build status
[11:38:21.846] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:21.846] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:38:0) after 1m0s
[11:39:21.871] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:38:0)
[11:39:21.871] Timer tick, asking Buildbucket for the build status
[11:39:22.070] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:22.070] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:39:0) after 1m0s
[11:40:22.102] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:39:0)
[11:40:22.102] Timer tick, asking Buildbucket for the build status
[11:40:22.169] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:22.169] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:40:0) after 1m0s
[11:41:22.268] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:40:0)
[11:41:22.268] Timer tick, asking Buildbucket for the build status
[11:41:22.349] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:22.349] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:41:0) after 1m0s
[11:42:22.419] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:41:0)
[11:42:22.419] Timer tick, asking Buildbucket for the build status
[11:42:22.547] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:22.547] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:42:0) after 1m0s
[11:43:22.603] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:42:0)
[11:43:22.603] Timer tick, asking Buildbucket for the build status
[11:43:22.975] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:22.975] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:43:0) after 1m0s
[11:44:23.038] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:43:0)
[11:44:23.038] Timer tick, asking Buildbucket for the build status
[11:44:23.346] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:23.346] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:44:0) after 1m0s
[11:45:23.383] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:44:0)
[11:45:23.383] Timer tick, asking Buildbucket for the build status
[11:45:23.449] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:23.449] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:45:0) after 1m0s
[11:46:23.510] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:45:0)
[11:46:23.510] Timer tick, asking Buildbucket for the build status
[11:46:23.572] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:23.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:46:0) after 1m0s
[11:47:23.627] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:46:0)
[11:47:23.627] Timer tick, asking Buildbucket for the build status
[11:47:23.702] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:23.702] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:47:0) after 1m0s
[11:48:23.794] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:47:0)
[11:48:23.794] Timer tick, asking Buildbucket for the build status
[11:48:23.936] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:23.936] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:48:0) after 1m0s
[11:49:24.002] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:48:0)
[11:49:24.002] Timer tick, asking Buildbucket for the build status
[11:49:24.182] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:24.182] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:49:0) after 1m0s
[11:50:24.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:49:0)
[11:50:24.272] Timer tick, asking Buildbucket for the build status
[11:50:24.360] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:24.360] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:50:0) after 1m0s
[11:51:24.358] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:50:0)
[11:51:24.358] Timer tick, asking Buildbucket for the build status
[11:51:24.433] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:24.433] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:51:0) after 1m0s
[11:52:24.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:51:0)
[11:52:24.500] Timer tick, asking Buildbucket for the build status
[11:52:24.563] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:24.563] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:52:0) after 1m0s
[11:53:24.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:52:0)
[11:53:24.591] Timer tick, asking Buildbucket for the build status
[11:53:24.731] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:24.731] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:53:0) after 1m0s
[11:54:24.777] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:53:0)
[11:54:24.777] Timer tick, asking Buildbucket for the build status
[11:54:24.860] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:54:0) after 1m0s
[11:55:24.884] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:54:0)
[11:55:24.884] Timer tick, asking Buildbucket for the build status
[11:55:24.957] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:24.957] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:55:0) after 1m0s
[11:56:24.984] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:55:0)
[11:56:24.984] Timer tick, asking Buildbucket for the build status
[11:56:25.061] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:25.061] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:56:0) after 1m0s
[11:57:25.092] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:56:0)
[11:57:25.092] Timer tick, asking Buildbucket for the build status
[11:57:25.420] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:25.420] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:57:0) after 1m0s
[11:58:25.406] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:57:0)
[11:58:25.406] Timer tick, asking Buildbucket for the build status
[11:58:25.542] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:25.542] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:58:0) after 1m0s
[11:59:25.550] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:58:0)
[11:59:25.550] Timer tick, asking Buildbucket for the build status
[11:59:25.659] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:25.659] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:59:0) after 1m0s
[12:00:25.781] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:59:0)
[12:00:25.781] Timer tick, asking Buildbucket for the build status
[12:00:25.883] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:25.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:60:0) after 1m0s
[12:01:26.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:60:0)
[12:01:26.114] Timer tick, asking Buildbucket for the build status
[12:01:26.399] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:26.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:61:0) after 1m0s
[12:02:26.502] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:61:0)
[12:02:26.502] Timer tick, asking Buildbucket for the build status
[12:02:26.805] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:26.805] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:62:0) after 1m0s
[12:03:26.853] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:62:0)
[12:03:26.853] Timer tick, asking Buildbucket for the build status
[12:03:27.095] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:27.095] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:63:0) after 1m0s
[12:04:27.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:63:0)
[12:04:27.122] Timer tick, asking Buildbucket for the build status
[12:04:27.208] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:27.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:64:0) after 1m0s
[12:05:27.278] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:64:0)
[12:05:27.278] Timer tick, asking Buildbucket for the build status
[12:05:27.397] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:27.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:65:0) after 1m0s
[12:06:27.431] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:65:0)
[12:06:27.431] Timer tick, asking Buildbucket for the build status
[12:06:27.571] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:27.571] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:66:0) after 1m0s
[12:07:27.626] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:66:0)
[12:07:27.626] Timer tick, asking Buildbucket for the build status
[12:07:27.703] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:27.703] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:67:0) after 1m0s
[12:08:27.762] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:67:0)
[12:08:27.762] Timer tick, asking Buildbucket for the build status
[12:08:27.880] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:27.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:68:0) after 1m0s
[12:09:27.989] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:68:0)
[12:09:27.990] Timer tick, asking Buildbucket for the build status
[12:09:28.057] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:28.057] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:69:0) after 1m0s
[12:10:28.122] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:69:0)
[12:10:28.122] Timer tick, asking Buildbucket for the build status
[12:10:28.208] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:70:0) after 1m0s
[12:11:28.185] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:70:0)
[12:11:28.185] Timer tick, asking Buildbucket for the build status
[12:11:28.248] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:28.248] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:71:0) after 1m0s
[12:12:28.398] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:71:0)
[12:12:28.398] Timer tick, asking Buildbucket for the build status
[12:12:28.593] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:28.593] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:72:0) after 1m0s
[12:13:28.666] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:72:0)
[12:13:28.666] Timer tick, asking Buildbucket for the build status
[12:13:28.769] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:28.769] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:73:0) after 1m0s
[12:14:28.872] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:73:0)
[12:14:28.872] Timer tick, asking Buildbucket for the build status
[12:14:28.937] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:28.937] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:74:0) after 1m0s
[12:15:29.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:74:0)
[12:15:29.148] Timer tick, asking Buildbucket for the build status
[12:15:29.310] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:29.310] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:75:0) after 1m0s
[12:16:29.361] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:75:0)
[12:16:29.361] Timer tick, asking Buildbucket for the build status
[12:16:29.572] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:29.572] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:76:0) after 1m0s
[12:17:29.663] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:76:0)
[12:17:29.663] Timer tick, asking Buildbucket for the build status
[12:17:29.733] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:29.733] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:77:0) after 1m0s
[12:18:29.807] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:77:0)
[12:18:29.807] Timer tick, asking Buildbucket for the build status
[12:18:29.921] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:29.921] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:78:0) after 1m0s
[12:19:29.997] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:78:0)
[12:19:29.997] Timer tick, asking Buildbucket for the build status
[12:19:30.086] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:30.086] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:79:0) after 1m0s
[12:20:30.266] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:79:0)
[12:20:30.267] Timer tick, asking Buildbucket for the build status
[12:20:30.717] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:30.717] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:80:0) after 1m0s
[12:21:30.800] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:80:0)
[12:21:30.800] Timer tick, asking Buildbucket for the build status
[12:21:30.883] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:30.883] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:81:0) after 1m0s
[12:22:31.137] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:81:0)
[12:22:31.137] Timer tick, asking Buildbucket for the build status
[12:22:31.221] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:31.221] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:82:0) after 1m0s
[12:23:31.311] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:82:0)
[12:23:31.311] Timer tick, asking Buildbucket for the build status
[12:23:31.556] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:31.556] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:83:0) after 1m0s
[12:24:31.655] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:83:0)
[12:24:31.655] Timer tick, asking Buildbucket for the build status
[12:24:31.776] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:31.776] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:84:0) after 1m0s
[12:25:31.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:84:0)
[12:25:32.007] Timer tick, asking Buildbucket for the build status
[12:25:32.093] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:32.093] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:85:0) after 1m0s
[12:26:32.220] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:85:0)
[12:26:32.220] Timer tick, asking Buildbucket for the build status
[12:26:32.296] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:32.296] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:86:0) after 1m0s
[12:27:32.338] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:86:0)
[12:27:32.338] Timer tick, asking Buildbucket for the build status
[12:27:32.397] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:32.397] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:87:0) after 1m0s
[12:28:32.440] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:87:0)
[12:28:32.440] Timer tick, asking Buildbucket for the build status
[12:28:32.806] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:32.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:88:0) after 1m0s
[12:29:32.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:88:0)
[12:29:32.891] Timer tick, asking Buildbucket for the build status
[12:29:32.982] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:32.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:89:0) after 1m0s
[12:30:33.053] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:89:0)
[12:30:33.053] Timer tick, asking Buildbucket for the build status
[12:30:33.372] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:33.372] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:90:0) after 1m0s
[12:31:33.444] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:90:0)
[12:31:33.444] Timer tick, asking Buildbucket for the build status
[12:31:33.527] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:33.527] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:91:0) after 1m0s
[12:32:33.546] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:91:0)
[12:32:33.546] Timer tick, asking Buildbucket for the build status
[12:32:33.806] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:33.806] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:92:0) after 1m0s
[12:33:33.856] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:92:0)
[12:33:33.856] Timer tick, asking Buildbucket for the build status
[12:33:34.043] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:34.043] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:93:0) after 1m0s
[12:34:34.097] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:93:0)
[12:34:34.098] Timer tick, asking Buildbucket for the build status
[12:34:34.177] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:34.177] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:94:0) after 1m0s
[12:35:34.259] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:94:0)
[12:35:34.259] Timer tick, asking Buildbucket for the build status
[12:35:34.348] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:34.348] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:95:0) after 1m0s
[12:36:34.497] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:95:0)
[12:36:34.497] Timer tick, asking Buildbucket for the build status
[12:36:34.598] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:34.598] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:96:0) after 1m0s
[12:37:34.711] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:96:0)
[12:37:34.711] Timer tick, asking Buildbucket for the build status
[12:37:34.790] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:34.790] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:97:0) after 1m0s
[12:38:34.859] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:97:0)
[12:38:34.859] Timer tick, asking Buildbucket for the build status
[12:38:34.976] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:34.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:98:0) after 1m0s
[12:39:35.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:98:0)
[12:39:35.079] Timer tick, asking Buildbucket for the build status
[12:39:35.234] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:35.234] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:99:0) after 1m0s
[12:40:35.273] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:99:0)
[12:40:35.273] Timer tick, asking Buildbucket for the build status
[12:40:35.361] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:35.361] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:100:0) after 1m0s
[12:41:35.460] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:100:0)
[12:41:35.460] Timer tick, asking Buildbucket for the build status
[12:41:36.152] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:36.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:101:0) after 1m0s
[12:42:36.202] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:101:0)
[12:42:36.202] Timer tick, asking Buildbucket for the build status
[12:42:36.271] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:36.271] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:102:0) after 1m0s
[12:43:36.272] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:102:0)
[12:43:36.272] Timer tick, asking Buildbucket for the build status
[12:43:36.422] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:36.422] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:103:0) after 1m0s
[12:44:36.486] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:103:0)
[12:44:36.486] Timer tick, asking Buildbucket for the build status
[12:44:36.679] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:36.679] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:104:0) after 1m0s
[12:45:36.718] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:104:0)
[12:45:36.718] Timer tick, asking Buildbucket for the build status
[12:45:36.977] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:36.977] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:105:0) after 1m0s
[12:46:37.069] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:105:0)
[12:46:37.069] Timer tick, asking Buildbucket for the build status
[12:46:37.161] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:37.161] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:106:0) after 1m0s
[12:47:37.235] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:106:0)
[12:47:37.235] Timer tick, asking Buildbucket for the build status
[12:47:37.465] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:37.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:107:0) after 1m0s
[12:48:37.591] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:107:0)
[12:48:37.591] Timer tick, asking Buildbucket for the build status
[12:48:37.704] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:37.704] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:108:0) after 1m0s
[12:49:37.795] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:108:0)
[12:49:37.795] Timer tick, asking Buildbucket for the build status
[12:49:37.866] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:37.867] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:109:0) after 1m0s
[12:50:38.073] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:109:0)
[12:50:38.073] Timer tick, asking Buildbucket for the build status
[12:50:38.262] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:38.262] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:110:0) after 1m0s
[12:51:38.370] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:110:0)
[12:51:38.370] Timer tick, asking Buildbucket for the build status
[12:51:38.502] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:38.502] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:111:0) after 1m0s
[12:52:38.595] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:111:0)
[12:52:38.595] Timer tick, asking Buildbucket for the build status
[12:52:38.838] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:38.838] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:112:0) after 1m0s
[12:53:38.851] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:112:0)
[12:53:38.851] Timer tick, asking Buildbucket for the build status
[12:53:39.089] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:39.089] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:113:0) after 1m0s
[12:54:39.148] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:113:0)
[12:54:39.148] Timer tick, asking Buildbucket for the build status
[12:54:39.365] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:39.365] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:114:0) after 1m0s
[12:55:39.364] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:114:0)
[12:55:39.364] Timer tick, asking Buildbucket for the build status
[12:55:39.437] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:39.437] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:115:0) after 1m0s
[12:56:39.476] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:115:0)
[12:56:39.476] Timer tick, asking Buildbucket for the build status
[12:56:39.555] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:39.555] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:116:0) after 1m0s
[12:57:39.585] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:116:0)
[12:57:39.585] Timer tick, asking Buildbucket for the build status
[12:57:39.806] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:39.807] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:117:0) after 1m0s
[12:58:39.815] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:117:0)
[12:58:39.815] Timer tick, asking Buildbucket for the build status
[12:58:39.998] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:39.998] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:118:0) after 1m0s
[12:59:40.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:118:0)
[12:59:40.062] Timer tick, asking Buildbucket for the build status
[12:59:40.270] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:40.270] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:119:0) after 1m0s
[13:00:40.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:119:0)
[13:00:40.347] Timer tick, asking Buildbucket for the build status
[13:00:40.524] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:40.524] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:120:0) after 1m0s
[13:01:40.798] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:120:0)
[13:01:40.798] Timer tick, asking Buildbucket for the build status
[13:01:40.916] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:40.916] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:121:0) after 1m0s
[13:02:40.992] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:121:0)
[13:02:40.992] Timer tick, asking Buildbucket for the build status
[13:02:41.105] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:41.105] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:122:0) after 1m0s
[13:03:41.155] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:122:0)
[13:03:41.155] Timer tick, asking Buildbucket for the build status
[13:03:41.294] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:41.294] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:123:0) after 1m0s
[13:04:41.326] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:123:0)
[13:04:41.326] Timer tick, asking Buildbucket for the build status
[13:04:41.473] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:41.473] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:124:0) after 1m0s
[13:05:41.500] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:124:0)
[13:05:41.500] Timer tick, asking Buildbucket for the build status
[13:05:41.645] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:41.645] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:125:0) after 1m0s
[13:06:41.678] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:125:0)
[13:06:41.678] Timer tick, asking Buildbucket for the build status
[13:06:41.760] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:41.760] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:126:0) after 1m0s
[13:07:41.789] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:126:0)
[13:07:41.789] Timer tick, asking Buildbucket for the build status
[13:07:41.973] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:41.973] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:127:0) after 1m0s
[13:08:42.132] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:127:0)
[13:08:42.132] Timer tick, asking Buildbucket for the build status
[13:08:42.391] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:42.391] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:128:0) after 1m0s
[13:09:42.392] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:128:0)
[13:09:42.392] Timer tick, asking Buildbucket for the build status
[13:09:42.500] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:42.500] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:129:0) after 1m0s
[13:10:42.517] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:129:0)
[13:10:42.517] Timer tick, asking Buildbucket for the build status
[13:10:42.616] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:42.616] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:130:0) after 1m0s
[13:11:42.657] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:130:0)
[13:11:42.657] Timer tick, asking Buildbucket for the build status
[13:11:42.857] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:42.857] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:131:0) after 1m0s
[13:12:42.939] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:131:0)
[13:12:42.939] Timer tick, asking Buildbucket for the build status
[13:12:43.023] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:43.023] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:132:0) after 1m0s
[13:13:43.005] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:132:0)
[13:13:43.005] Timer tick, asking Buildbucket for the build status
[13:13:43.186] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:43.186] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:133:0) after 1m0s
[13:14:43.211] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:133:0)
[13:14:43.211] Timer tick, asking Buildbucket for the build status
[13:14:43.341] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:43.341] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:134:0) after 1m0s
[13:15:43.344] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:134:0)
[13:15:43.344] Timer tick, asking Buildbucket for the build status
[13:15:43.450] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:43.450] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:135:0) after 1m0s
[13:16:43.543] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:135:0)
[13:16:43.543] Timer tick, asking Buildbucket for the build status
[13:16:43.892] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:43.892] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:136:0) after 1m0s
[13:17:43.906] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:136:0)
[13:17:43.906] Timer tick, asking Buildbucket for the build status
[13:17:43.976] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:43.976] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:137:0) after 1m0s
[13:18:44.062] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:137:0)
[13:18:44.062] Timer tick, asking Buildbucket for the build status
[13:18:44.210] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:44.210] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:138:0) after 1m0s
[13:19:44.389] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:138:0)
[13:19:44.389] Timer tick, asking Buildbucket for the build status
[13:19:44.767] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:44.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:139:0) after 1m0s
[13:20:44.897] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:139:0)
[13:20:44.898] Timer tick, asking Buildbucket for the build status
[13:20:45.001] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:45.001] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:140:0) after 1m0s
[13:21:45.288] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:140:0)
[13:21:45.288] Timer tick, asking Buildbucket for the build status
[13:21:45.484] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:45.485] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:141:0) after 1m0s
[13:22:45.575] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:141:0)
[13:22:45.575] Timer tick, asking Buildbucket for the build status
[13:22:45.676] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:45.676] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:142:0) after 1m0s
[13:23:46.113] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:142:0)
[13:23:46.113] Timer tick, asking Buildbucket for the build status
[13:23:46.250] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:46.250] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:143:0) after 1m0s
[13:24:46.489] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:143:0)
[13:24:46.489] Timer tick, asking Buildbucket for the build status
[13:24:46.972] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:46.972] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:144:0) after 1m0s
[13:25:47.106] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:144:0)
[13:25:47.106] Timer tick, asking Buildbucket for the build status
[13:25:47.171] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:47.171] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:145:0) after 1m0s
[13:26:47.349] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:145:0)
[13:26:47.349] Timer tick, asking Buildbucket for the build status
[13:26:47.452] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:47.452] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:146:0) after 1m0s
[13:27:47.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:146:0)
[13:27:47.483] Timer tick, asking Buildbucket for the build status
[13:27:47.561] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:47.561] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:147:0) after 1m0s
[13:28:47.617] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:147:0)
[13:28:47.617] Timer tick, asking Buildbucket for the build status
[13:28:47.884] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:47.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:148:0) after 1m0s
[13:29:47.943] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:148:0)
[13:29:47.943] Timer tick, asking Buildbucket for the build status
[13:29:48.124] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:48.124] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:149:0) after 1m0s
[13:30:48.243] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:149:0)
[13:30:48.243] Timer tick, asking Buildbucket for the build status
[13:30:49.238] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:49.238] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:150:0) after 1m0s
[13:31:49.347] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:150:0)
[13:31:49.347] Timer tick, asking Buildbucket for the build status
[13:31:49.419] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:49.419] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:151:0) after 1m0s
[13:32:49.495] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:151:0)
[13:32:49.495] Timer tick, asking Buildbucket for the build status
[13:32:49.767] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:32:49.767] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:152:0) after 1m0s
[13:33:49.891] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:152:0)
[13:33:49.891] Timer tick, asking Buildbucket for the build status
[13:33:50.203] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:50.203] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:153:0) after 1m0s
[13:34:50.313] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:153:0)
[13:34:50.313] Timer tick, asking Buildbucket for the build status
[13:34:50.399] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:50.399] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:154:0) after 1m0s
[13:35:50.483] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:154:0)
[13:35:50.483] Timer tick, asking Buildbucket for the build status
[13:35:50.911] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:50.911] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:155:0) after 1m0s
[13:36:50.921] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:155:0)
[13:36:50.921] Timer tick, asking Buildbucket for the build status
[13:36:50.982] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:50.982] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:156:0) after 1m0s
[13:37:51.111] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:156:0)
[13:37:51.111] Timer tick, asking Buildbucket for the build status
[13:37:51.227] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:51.227] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:157:0) after 1m0s
[13:38:51.339] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:157:0)
[13:38:51.339] Timer tick, asking Buildbucket for the build status
[13:38:51.465] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:38:51.465] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:158:0) after 1m0s
[13:39:51.544] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:158:0)
[13:39:51.544] Timer tick, asking Buildbucket for the build status
[13:39:51.902] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:39:51.902] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:159:0) after 1m0s
[13:40:51.998] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:159:0)
[13:40:51.998] Timer tick, asking Buildbucket for the build status
[13:40:52.293] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:40:52.293] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:160:0) after 1m0s
[13:41:52.478] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:160:0)
[13:41:52.478] Timer tick, asking Buildbucket for the build status
[13:41:52.685] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:41:52.685] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:161:0) after 1m0s
[13:42:52.722] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:161:0)
[13:42:52.722] Timer tick, asking Buildbucket for the build status
[13:42:52.829] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:42:52.829] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:162:0) after 1m0s
[13:43:52.857] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:162:0)
[13:43:52.857] Timer tick, asking Buildbucket for the build status
[13:43:52.969] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:43:52.969] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:163:0) after 1m0s
[13:44:53.036] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:163:0)
[13:44:53.036] Timer tick, asking Buildbucket for the build status
[13:44:53.144] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:44:53.144] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:164:0) after 1m0s
[13:45:53.330] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:164:0)
[13:45:53.330] Timer tick, asking Buildbucket for the build status
[13:45:53.737] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:45:53.737] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:165:0) after 1m0s
[13:46:54.112] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:165:0)
[13:46:54.112] Timer tick, asking Buildbucket for the build status
[13:46:54.570] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:46:54.570] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:166:0) after 1m0s
[13:47:54.646] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:166:0)
[13:47:54.646] Timer tick, asking Buildbucket for the build status
[13:47:54.885] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:47:54.885] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:167:0) after 1m0s
[13:48:54.993] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:167:0)
[13:48:54.993] Timer tick, asking Buildbucket for the build status
[13:48:55.218] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:48:55.218] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:168:0) after 1m0s
[13:49:55.317] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:168:0)
[13:49:55.317] Timer tick, asking Buildbucket for the build status
[13:49:55.501] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:49:55.501] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:169:0) after 1m0s
[13:50:55.618] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:169:0)
[13:50:55.618] Timer tick, asking Buildbucket for the build status
[13:50:55.930] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:50:55.930] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:170:0) after 1m0s
[13:51:56.079] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:170:0)
[13:51:56.079] Timer tick, asking Buildbucket for the build status
[13:51:56.152] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:51:56.152] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:171:0) after 1m0s
[13:52:56.355] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:171:0)
[13:52:56.355] Timer tick, asking Buildbucket for the build status
[13:52:56.493] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:52:56.493] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:172:0) after 1m0s
[13:53:56.577] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:172:0)
[13:53:56.577] Timer tick, asking Buildbucket for the build status
[13:53:56.880] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:53:56.880] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:173:0) after 1m0s
[13:54:56.911] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:173:0)
[13:54:56.911] Timer tick, asking Buildbucket for the build status
[13:54:56.978] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:54:56.978] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:174:0) after 1m0s
[13:55:57.043] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:174:0)
[13:55:57.043] Timer tick, asking Buildbucket for the build status
[13:55:57.255] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:55:57.255] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:175:0) after 1m0s
[13:56:57.353] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:175:0)
[13:56:57.353] Timer tick, asking Buildbucket for the build status
[13:56:57.497] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:56:57.497] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:176:0) after 1m0s
[13:57:57.739] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:176:0)
[13:57:57.739] Timer tick, asking Buildbucket for the build status
[13:57:57.816] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:57:57.816] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:177:0) after 1m0s
[13:58:57.960] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:177:0)
[13:58:57.960] Timer tick, asking Buildbucket for the build status
[13:58:58.136] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:58:58.136] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:178:0) after 1m0s
[13:59:58.212] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:178:0)
[13:59:58.212] Timer tick, asking Buildbucket for the build status
[13:59:58.273] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:59:58.273] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:179:0) after 1m0s
[14:00:58.450] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:179:0)
[14:00:58.450] Timer tick, asking Buildbucket for the build status
[14:00:58.583] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:00:58.584] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:180:0) after 1m0s
[14:01:58.974] Handling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:180:0)
[14:01:58.974] Timer tick, asking Buildbucket for the build status
[14:01:59.120] Build 8865109905896183696: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:01:59.120] Scheduling timer "check-buildbucket-build-status" (chromium/win-official:9030539968385165712:181:0) after 1m0s
[14:02:27.684] Received PubSub notification, asking Buildbucket for the build status
[14:02:27.750] Build 8865109905896183696: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:02:27.750] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603980146554258",
"created_by": "project:chromium",
"created_ts": "1603969392836132",
"id": "8865109905896183696",
"parameters_json": "{\"builder_name\": \"win-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e6168b866f984030d784123c1349ca1b3cc2f38\"}}",
"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\": \"8e6168b866f984030d784123c1349ca1b3cc2f38\", \"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-3-6dkk\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win-official\", \"buildnumber\": 918, \"got_angle_revision\": \"3591997b58bfb1aab16a2d3d071529275bb84b05\", \"got_dawn_revision\": \"a584311a6a73a2b8b21703874742128c6d92f549\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"8e6168b866f984030d784123c1349ca1b3cc2f38\", \"got_revision_cp\": \"refs/heads/master@{#822102}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"2be25f08deafe1fb1eada032cd3b2aae3021f367\", \"got_v8_revision\": \"74cd21ef855b0602e4b70e049794699fe06b4f82\", \"got_v8_revision_cp\": \"refs/heads/8.8.206@{#1}\", \"got_webrtc_revision\": \"ee24eb66d23ffea5ef729dc340e1fc4381c72a4a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32507}\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8e6168b866f984030d784123c1349ca1b3cc2f38\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_9b3ebe5fd1c5be87380c40d216747346a59b28cf26de183f0e8e2b32e944d3c8_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-6dkk\"], \"image\": [\"chrome-win10-1703-20092300-22ba5320847\"], \"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\": [\"5614-d862eaa\"], \"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": "1603969430380436",
"status": "COMPLETED",
"status_changed_ts": "1603980147056726",
"tags": [
"build_address:luci.chromium.ci/win-official/918",
"builder:win-official",
"buildset:commit/git/8e6168b866f984030d784123c1349ca1b3cc2f38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8e6168b866f984030d784123c1349ca1b3cc2f38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030539968385165712",
"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/8865109905896183696/+/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:4f8cd82d4c666810",
"user_agent:luci-scheduler"
],
"updated_ts": "1603980147061686",
"url": "https://ci.chromium.org/b/8865109905896183696",
"utcnow_ts": "1603980147741365"
}
}
[14:02:27.750] Invocation finished in 2h59m16.672458478s with status SUCCEEDED