[05:31:42.875] New invocation is queued and will start shortly
[05:31:44.186] Starting the invocation (attempt 1)
[05:31:44.224] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:31:44.225] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:31:44.225] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021954110894240400",
"parameters_json": "{\"builder_name\":\"win32-official\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:win32-official",
"scheduler_invocation_id:9021954110894240400",
"scheduler_job_id:chromium/win32-official",
"user_agent:luci-scheduler",
"buildset:commit/git/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"gitiles_ref:refs/heads/master"
]
}
[05:31:46.793] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612157504395005",
"id": "8856524048630143440",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612157506297667",
"tags": [
"build_address:luci.chromium.ci/win32-official/1457",
"builder:win32-official",
"buildset:commit/git/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021954110894240400",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856524048630143440/+/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": "1612157506297914",
"url": "https://ci.chromium.org/b/8856524048630143440",
"utcnow_ts": "1612157506779758"
}
}
[05:31:46.794] Task URL: https://ci.chromium.org/b/8856524048630143440
[05:31:46.794] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:2:0) after 1m0s
[05:32:07.544] Received PubSub notification, asking Buildbucket for the build status
[05:32:07.614] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:46.908] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:2:0)
[05:32:46.908] Timer tick, asking Buildbucket for the build status
[05:32:46.978] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:46.978] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:4:0) after 1m0s
[05:33:46.995] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:4:0)
[05:33:46.995] Timer tick, asking Buildbucket for the build status
[05:33:47.090] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:47.090] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:5:0) after 1m0s
[05:34:47.112] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:5:0)
[05:34:47.112] Timer tick, asking Buildbucket for the build status
[05:34:47.238] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:47.238] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:6:0) after 1m0s
[05:35:47.263] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:6:0)
[05:35:47.263] Timer tick, asking Buildbucket for the build status
[05:35:47.497] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:47.497] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:7:0) after 1m0s
[05:36:47.509] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:7:0)
[05:36:47.509] Timer tick, asking Buildbucket for the build status
[05:36:47.605] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:47.605] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:8:0) after 1m0s
[05:37:47.659] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:8:0)
[05:37:47.659] Timer tick, asking Buildbucket for the build status
[05:37:47.722] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:47.722] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:9:0) after 1m0s
[05:38:47.777] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:9:0)
[05:38:47.777] Timer tick, asking Buildbucket for the build status
[05:38:47.862] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:47.862] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:10:0) after 1m0s
[05:39:47.929] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:10:0)
[05:39:47.929] Timer tick, asking Buildbucket for the build status
[05:39:48.001] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:48.001] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:11:0) after 1m0s
[05:40:48.052] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:11:0)
[05:40:48.052] Timer tick, asking Buildbucket for the build status
[05:40:48.695] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:48.695] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:12:0) after 1m0s
[05:41:48.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:12:0)
[05:41:48.716] Timer tick, asking Buildbucket for the build status
[05:41:48.812] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:48.812] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:13:0) after 1m0s
[05:42:48.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:13:0)
[05:42:48.829] Timer tick, asking Buildbucket for the build status
[05:42:48.929] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:48.929] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:14:0) after 1m0s
[05:43:48.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:14:0)
[05:43:48.949] Timer tick, asking Buildbucket for the build status
[05:43:50.271] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:50.271] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:15:0) after 1m0s
[05:44:50.305] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:15:0)
[05:44:50.305] Timer tick, asking Buildbucket for the build status
[05:44:51.277] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:51.277] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:16:0) after 1m0s
[05:45:51.327] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:16:0)
[05:45:51.327] Timer tick, asking Buildbucket for the build status
[05:45:51.437] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:51.437] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:17:0) after 1m0s
[05:46:51.461] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:17:0)
[05:46:51.461] Timer tick, asking Buildbucket for the build status
[05:46:51.545] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:51.545] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:18:0) after 1m0s
[05:47:51.598] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:18:0)
[05:47:51.598] Timer tick, asking Buildbucket for the build status
[05:47:51.679] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:51.679] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:19:0) after 1m0s
[05:48:51.731] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:19:0)
[05:48:51.731] Timer tick, asking Buildbucket for the build status
[05:48:51.808] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:51.808] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:20:0) after 1m0s
[05:49:51.861] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:20:0)
[05:49:51.861] Timer tick, asking Buildbucket for the build status
[05:49:51.936] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:51.936] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:21:0) after 1m0s
[05:50:51.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:21:0)
[05:50:51.964] Timer tick, asking Buildbucket for the build status
[05:50:52.022] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:52.022] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:22:0) after 1m0s
[05:51:52.077] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:22:0)
[05:51:52.077] Timer tick, asking Buildbucket for the build status
[05:51:52.185] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:52.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:23:0) after 1m0s
[05:52:52.234] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:23:0)
[05:52:52.234] Timer tick, asking Buildbucket for the build status
[05:52:52.293] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:52.293] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:24:0) after 1m0s
[05:53:52.391] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:24:0)
[05:53:52.391] Timer tick, asking Buildbucket for the build status
[05:53:52.448] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:52.448] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:25:0) after 1m0s
[05:54:52.486] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:25:0)
[05:54:52.486] Timer tick, asking Buildbucket for the build status
[05:54:52.557] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:52.557] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:26:0) after 1m0s
[05:55:52.587] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:26:0)
[05:55:52.587] Timer tick, asking Buildbucket for the build status
[05:55:52.643] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:52.643] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:27:0) after 1m0s
[05:56:52.677] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:27:0)
[05:56:52.677] Timer tick, asking Buildbucket for the build status
[05:56:52.761] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:52.761] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:28:0) after 1m0s
[05:57:52.780] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:28:0)
[05:57:52.780] Timer tick, asking Buildbucket for the build status
[05:57:53.110] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:53.110] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:29:0) after 1m0s
[05:58:53.135] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:29:0)
[05:58:53.135] Timer tick, asking Buildbucket for the build status
[05:58:53.191] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:53.191] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:30:0) after 1m0s
[05:59:53.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:30:0)
[05:59:53.176] Timer tick, asking Buildbucket for the build status
[05:59:53.474] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:53.474] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:31:0) after 1m0s
[06:00:53.519] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:31:0)
[06:00:53.519] Timer tick, asking Buildbucket for the build status
[06:00:53.692] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:53.692] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:32:0) after 1m0s
[06:01:53.716] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:32:0)
[06:01:53.716] Timer tick, asking Buildbucket for the build status
[06:01:53.815] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:53.815] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:33:0) after 1m0s
[06:02:53.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:33:0)
[06:02:53.881] Timer tick, asking Buildbucket for the build status
[06:02:54.144] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:54.144] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:34:0) after 1m0s
[06:03:54.177] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:34:0)
[06:03:54.177] Timer tick, asking Buildbucket for the build status
[06:03:54.622] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:54.622] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:35:0) after 1m0s
[06:04:54.639] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:35:0)
[06:04:54.639] Timer tick, asking Buildbucket for the build status
[06:04:54.736] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:54.736] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:36:0) after 1m0s
[06:05:54.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:36:0)
[06:05:54.754] Timer tick, asking Buildbucket for the build status
[06:05:54.848] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:54.848] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:37:0) after 1m0s
[06:06:54.897] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:37:0)
[06:06:54.897] Timer tick, asking Buildbucket for the build status
[06:06:55.336] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:55.336] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:38:0) after 1m0s
[06:07:55.352] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:38:0)
[06:07:55.352] Timer tick, asking Buildbucket for the build status
[06:07:55.439] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:55.439] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:39:0) after 1m0s
[06:08:55.441] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:39:0)
[06:08:55.441] Timer tick, asking Buildbucket for the build status
[06:08:55.719] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:55.719] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:40:0) after 1m0s
[06:09:55.798] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:40:0)
[06:09:55.798] Timer tick, asking Buildbucket for the build status
[06:09:56.428] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:56.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:41:0) after 1m0s
[06:10:56.536] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:41:0)
[06:10:56.536] Timer tick, asking Buildbucket for the build status
[06:10:56.614] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:56.614] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:42:0) after 1m0s
[06:11:56.642] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:42:0)
[06:11:56.642] Timer tick, asking Buildbucket for the build status
[06:11:56.900] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:56.900] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:43:0) after 1m0s
[06:12:56.914] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:43:0)
[06:12:56.914] Timer tick, asking Buildbucket for the build status
[06:12:56.983] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:56.983] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:44:0) after 1m0s
[06:13:57.251] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:44:0)
[06:13:57.251] Timer tick, asking Buildbucket for the build status
[06:13:57.401] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:57.401] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:45:0) after 1m0s
[06:14:57.540] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:45:0)
[06:14:57.540] Timer tick, asking Buildbucket for the build status
[06:14:57.599] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:57.599] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:46:0) after 1m0s
[06:15:57.684] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:46:0)
[06:15:57.684] Timer tick, asking Buildbucket for the build status
[06:15:57.743] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:57.743] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:47:0) after 1m0s
[06:16:57.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:47:0)
[06:16:57.814] Timer tick, asking Buildbucket for the build status
[06:16:57.931] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:57.931] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:48:0) after 1m0s
[06:17:58.120] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:48:0)
[06:17:58.120] Timer tick, asking Buildbucket for the build status
[06:17:58.198] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:58.198] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:49:0) after 1m0s
[06:18:58.318] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:49:0)
[06:18:58.318] Timer tick, asking Buildbucket for the build status
[06:18:58.381] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:58.382] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:50:0) after 1m0s
[06:19:58.423] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:50:0)
[06:19:58.423] Timer tick, asking Buildbucket for the build status
[06:19:58.515] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:58.515] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:51:0) after 1m0s
[06:20:58.578] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:51:0)
[06:20:58.578] Timer tick, asking Buildbucket for the build status
[06:20:58.640] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:58.640] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:52:0) after 1m0s
[06:21:58.675] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:52:0)
[06:21:58.675] Timer tick, asking Buildbucket for the build status
[06:21:58.758] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:58.758] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:53:0) after 1m0s
[06:22:58.832] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:53:0)
[06:22:58.832] Timer tick, asking Buildbucket for the build status
[06:22:58.882] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:58.882] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:54:0) after 1m0s
[06:23:58.923] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:54:0)
[06:23:58.923] Timer tick, asking Buildbucket for the build status
[06:23:58.991] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:58.991] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:55:0) after 1m0s
[06:24:59.009] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:55:0)
[06:24:59.009] Timer tick, asking Buildbucket for the build status
[06:24:59.119] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:59.119] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:56:0) after 1m0s
[06:25:59.154] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:56:0)
[06:25:59.154] Timer tick, asking Buildbucket for the build status
[06:25:59.323] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:59.323] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:57:0) after 1m0s
[06:26:59.344] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:57:0)
[06:26:59.344] Timer tick, asking Buildbucket for the build status
[06:26:59.433] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:59.433] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:58:0) after 1m0s
[06:27:59.456] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:58:0)
[06:27:59.456] Timer tick, asking Buildbucket for the build status
[06:27:59.594] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:59.594] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:59:0) after 1m0s
[06:28:59.613] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:59:0)
[06:28:59.613] Timer tick, asking Buildbucket for the build status
[06:28:59.795] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:59.795] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:60:0) after 1m0s
[06:29:59.818] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:60:0)
[06:29:59.818] Timer tick, asking Buildbucket for the build status
[06:29:59.887] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:59.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:61:0) after 1m0s
[06:30:59.925] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:61:0)
[06:30:59.925] Timer tick, asking Buildbucket for the build status
[06:31:00.295] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:00.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:62:0) after 1m0s
[06:32:02.027] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:62:0)
[06:32:02.027] Timer tick, asking Buildbucket for the build status
[06:32:02.169] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:02.169] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:63:0) after 1m0s
[06:33:02.546] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:63:0)
[06:33:02.546] Timer tick, asking Buildbucket for the build status
[06:33:02.831] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:02.831] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:64:0) after 1m0s
[06:34:03.030] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:64:0)
[06:34:03.030] Timer tick, asking Buildbucket for the build status
[06:34:03.150] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:03.150] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:65:0) after 1m0s
[06:35:03.211] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:65:0)
[06:35:03.211] Timer tick, asking Buildbucket for the build status
[06:35:03.322] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:03.322] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:66:0) after 1m0s
[06:36:03.413] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:66:0)
[06:36:03.413] Timer tick, asking Buildbucket for the build status
[06:36:03.740] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:03.740] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:67:0) after 1m0s
[06:37:03.769] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:67:0)
[06:37:03.769] Timer tick, asking Buildbucket for the build status
[06:37:03.886] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:03.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:68:0) after 1m0s
[06:38:04.026] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:68:0)
[06:38:04.026] Timer tick, asking Buildbucket for the build status
[06:38:04.091] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:69:0) after 1m0s
[06:39:04.228] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:69:0)
[06:39:04.228] Timer tick, asking Buildbucket for the build status
[06:39:04.502] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:04.502] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:70:0) after 1m0s
[06:40:04.715] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:70:0)
[06:40:04.715] Timer tick, asking Buildbucket for the build status
[06:40:04.786] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:04.786] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:71:0) after 1m0s
[06:41:05.089] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:71:0)
[06:41:05.090] Timer tick, asking Buildbucket for the build status
[06:41:05.765] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.765] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:72:0) after 1m0s
[06:42:05.784] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:72:0)
[06:42:05.784] Timer tick, asking Buildbucket for the build status
[06:42:05.918] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:05.918] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:73:0) after 1m0s
[06:43:06.113] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:73:0)
[06:43:06.113] Timer tick, asking Buildbucket for the build status
[06:43:06.186] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:06.186] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:74:0) after 1m0s
[06:44:06.343] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:74:0)
[06:44:06.343] Timer tick, asking Buildbucket for the build status
[06:44:06.678] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:06.678] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:75:0) after 1m0s
[06:45:06.726] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:75:0)
[06:45:06.726] Timer tick, asking Buildbucket for the build status
[06:45:06.807] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:76:0) after 1m0s
[06:46:06.917] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:76:0)
[06:46:06.917] Timer tick, asking Buildbucket for the build status
[06:46:07.125] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:07.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:77:0) after 1m0s
[06:47:07.203] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:77:0)
[06:47:07.203] Timer tick, asking Buildbucket for the build status
[06:47:07.330] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.330] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:78:0) after 1m0s
[06:48:07.485] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:78:0)
[06:48:07.485] Timer tick, asking Buildbucket for the build status
[06:48:07.586] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:07.586] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:79:0) after 1m0s
[06:49:07.633] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:79:0)
[06:49:07.633] Timer tick, asking Buildbucket for the build status
[06:49:07.771] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:07.771] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:80:0) after 1m0s
[06:50:07.864] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:80:0)
[06:50:07.864] Timer tick, asking Buildbucket for the build status
[06:50:07.941] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:07.941] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:81:0) after 1m0s
[06:51:08.229] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:81:0)
[06:51:08.229] Timer tick, asking Buildbucket for the build status
[06:51:08.288] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:08.288] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:82:0) after 1m0s
[06:52:08.595] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:82:0)
[06:52:08.595] Timer tick, asking Buildbucket for the build status
[06:52:08.716] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:08.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:83:0) after 1m0s
[06:53:08.753] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:83:0)
[06:53:08.753] Timer tick, asking Buildbucket for the build status
[06:53:08.985] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:08.985] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:84:0) after 1m0s
[06:54:09.015] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:84:0)
[06:54:09.015] Timer tick, asking Buildbucket for the build status
[06:54:09.445] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:09.445] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:85:0) after 1m0s
[06:55:09.700] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:85:0)
[06:55:09.700] Timer tick, asking Buildbucket for the build status
[06:55:09.784] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:09.784] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:86:0) after 1m0s
[06:56:10.002] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:86:0)
[06:56:10.002] Timer tick, asking Buildbucket for the build status
[06:56:10.073] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:10.073] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:87:0) after 1m0s
[06:57:10.127] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:87:0)
[06:57:10.127] Timer tick, asking Buildbucket for the build status
[06:57:10.210] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:10.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:88:0) after 1m0s
[06:58:10.297] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:88:0)
[06:58:10.297] Timer tick, asking Buildbucket for the build status
[06:58:10.367] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:10.367] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:89:0) after 1m0s
[06:59:10.505] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:89:0)
[06:59:10.505] Timer tick, asking Buildbucket for the build status
[06:59:10.584] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:10.584] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:90:0) after 1m0s
[07:00:10.701] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:90:0)
[07:00:10.701] Timer tick, asking Buildbucket for the build status
[07:00:10.780] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:10.780] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:91:0) after 1m0s
[07:01:10.847] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:91:0)
[07:01:10.847] Timer tick, asking Buildbucket for the build status
[07:01:10.903] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:10.903] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:92:0) after 1m0s
[07:02:11.042] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:92:0)
[07:02:11.042] Timer tick, asking Buildbucket for the build status
[07:02:11.321] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:11.321] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:93:0) after 1m0s
[07:03:11.365] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:93:0)
[07:03:11.365] Timer tick, asking Buildbucket for the build status
[07:03:11.468] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:11.468] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:94:0) after 1m0s
[07:04:11.669] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:94:0)
[07:04:11.669] Timer tick, asking Buildbucket for the build status
[07:04:11.735] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:11.735] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:95:0) after 1m0s
[07:05:11.774] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:95:0)
[07:05:11.774] Timer tick, asking Buildbucket for the build status
[07:05:11.832] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:11.832] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:96:0) after 1m0s
[07:06:11.885] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:96:0)
[07:06:11.885] Timer tick, asking Buildbucket for the build status
[07:06:11.950] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:11.951] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:97:0) after 1m0s
[07:07:12.003] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:97:0)
[07:07:12.003] Timer tick, asking Buildbucket for the build status
[07:07:12.299] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:12.299] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:98:0) after 1m0s
[07:08:12.369] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:98:0)
[07:08:12.369] Timer tick, asking Buildbucket for the build status
[07:08:12.428] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:12.428] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:99:0) after 1m0s
[07:09:12.494] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:99:0)
[07:09:12.494] Timer tick, asking Buildbucket for the build status
[07:09:12.572] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:12.572] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:100:0) after 1m0s
[07:10:12.575] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:100:0)
[07:10:12.577] Timer tick, asking Buildbucket for the build status
[07:10:12.662] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:12.662] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:101:0) after 1m0s
[07:11:12.853] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:101:0)
[07:11:12.853] Timer tick, asking Buildbucket for the build status
[07:11:12.950] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:12.951] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:102:0) after 1m0s
[07:12:13.048] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:102:0)
[07:12:13.048] Timer tick, asking Buildbucket for the build status
[07:12:13.157] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:13.157] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:103:0) after 1m0s
[07:13:13.198] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:103:0)
[07:13:13.198] Timer tick, asking Buildbucket for the build status
[07:13:13.393] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:13.393] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:104:0) after 1m0s
[07:14:13.566] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:104:0)
[07:14:13.566] Timer tick, asking Buildbucket for the build status
[07:14:13.730] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:13.730] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:105:0) after 1m0s
[07:15:13.801] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:105:0)
[07:15:13.801] Timer tick, asking Buildbucket for the build status
[07:15:13.940] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:13.940] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:106:0) after 1m0s
[07:16:13.990] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:106:0)
[07:16:13.990] Timer tick, asking Buildbucket for the build status
[07:16:14.057] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:14.057] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:107:0) after 1m0s
[07:17:14.126] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:107:0)
[07:17:14.126] Timer tick, asking Buildbucket for the build status
[07:17:14.305] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:14.306] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:108:0) after 1m0s
[07:18:14.363] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:108:0)
[07:18:14.363] Timer tick, asking Buildbucket for the build status
[07:18:15.210] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:15.210] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:109:0) after 1m0s
[07:19:15.292] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:109:0)
[07:19:15.292] Timer tick, asking Buildbucket for the build status
[07:19:15.429] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:15.429] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:110:0) after 1m0s
[07:20:15.482] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:110:0)
[07:20:15.482] Timer tick, asking Buildbucket for the build status
[07:20:15.712] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:15.712] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:111:0) after 1m0s
[07:21:15.814] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:111:0)
[07:21:15.814] Timer tick, asking Buildbucket for the build status
[07:21:15.886] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:15.886] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:112:0) after 1m0s
[07:22:15.991] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:112:0)
[07:22:15.991] Timer tick, asking Buildbucket for the build status
[07:22:16.478] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:16.478] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:113:0) after 1m0s
[07:23:16.558] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:113:0)
[07:23:16.558] Timer tick, asking Buildbucket for the build status
[07:23:16.623] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:16.623] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:114:0) after 1m0s
[07:24:16.711] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:114:0)
[07:24:16.711] Timer tick, asking Buildbucket for the build status
[07:24:16.774] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:16.774] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:115:0) after 1m0s
[07:25:16.829] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:115:0)
[07:25:16.829] Timer tick, asking Buildbucket for the build status
[07:25:17.126] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:17.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:116:0) after 1m0s
[07:26:17.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:116:0)
[07:26:17.197] Timer tick, asking Buildbucket for the build status
[07:26:17.254] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:17.254] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:117:0) after 1m0s
[07:27:17.351] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:117:0)
[07:27:17.351] Timer tick, asking Buildbucket for the build status
[07:27:17.439] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:17.439] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:118:0) after 1m0s
[07:28:17.488] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:118:0)
[07:28:17.488] Timer tick, asking Buildbucket for the build status
[07:28:17.549] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:17.549] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:119:0) after 1m0s
[07:29:17.621] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:119:0)
[07:29:17.621] Timer tick, asking Buildbucket for the build status
[07:29:17.699] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:17.699] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:120:0) after 1m0s
[07:30:17.743] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:120:0)
[07:30:17.743] Timer tick, asking Buildbucket for the build status
[07:30:17.852] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:17.852] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:121:0) after 1m0s
[07:31:17.875] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:121:0)
[07:31:17.875] Timer tick, asking Buildbucket for the build status
[07:31:17.958] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:17.958] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:122:0) after 1m0s
[07:32:17.967] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:122:0)
[07:32:17.967] Timer tick, asking Buildbucket for the build status
[07:32:18.115] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:18.115] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:123:0) after 1m0s
[07:33:18.197] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:123:0)
[07:33:18.197] Timer tick, asking Buildbucket for the build status
[07:33:18.269] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:18.269] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:124:0) after 1m0s
[07:34:18.385] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:124:0)
[07:34:18.385] Timer tick, asking Buildbucket for the build status
[07:34:18.495] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:18.495] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:125:0) after 1m0s
[07:35:18.754] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:125:0)
[07:35:18.754] Timer tick, asking Buildbucket for the build status
[07:35:18.939] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:18.939] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:126:0) after 1m0s
[07:36:19.031] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:126:0)
[07:36:19.031] Timer tick, asking Buildbucket for the build status
[07:36:19.125] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:19.125] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:127:0) after 1m0s
[07:37:19.178] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:127:0)
[07:37:19.178] Timer tick, asking Buildbucket for the build status
[07:37:19.295] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:19.295] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:128:0) after 1m0s
[07:38:19.355] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:128:0)
[07:38:19.355] Timer tick, asking Buildbucket for the build status
[07:38:19.426] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:19.426] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:129:0) after 1m0s
[07:39:19.594] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:129:0)
[07:39:19.594] Timer tick, asking Buildbucket for the build status
[07:39:19.670] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:19.670] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:130:0) after 1m0s
[07:40:19.827] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:130:0)
[07:40:19.830] Timer tick, asking Buildbucket for the build status
[07:40:19.899] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:19.899] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:131:0) after 1m0s
[07:41:19.949] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:131:0)
[07:41:19.949] Timer tick, asking Buildbucket for the build status
[07:41:20.027] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:20.027] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:132:0) after 1m0s
[07:42:20.123] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:132:0)
[07:42:20.123] Timer tick, asking Buildbucket for the build status
[07:42:20.214] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:20.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:133:0) after 1m0s
[07:43:20.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:133:0)
[07:43:20.261] Timer tick, asking Buildbucket for the build status
[07:43:20.546] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:20.546] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:134:0) after 1m0s
[07:44:20.775] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:134:0)
[07:44:20.775] Timer tick, asking Buildbucket for the build status
[07:44:21.214] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:21.214] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:135:0) after 1m0s
[07:45:21.448] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:135:0)
[07:45:21.448] Timer tick, asking Buildbucket for the build status
[07:45:21.720] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:21.720] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:136:0) after 1m0s
[07:46:21.770] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:136:0)
[07:46:21.770] Timer tick, asking Buildbucket for the build status
[07:46:21.838] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:21.838] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:137:0) after 1m0s
[07:47:21.857] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:137:0)
[07:47:21.857] Timer tick, asking Buildbucket for the build status
[07:47:21.958] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:21.958] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:138:0) after 1m0s
[07:48:21.964] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:138:0)
[07:48:21.964] Timer tick, asking Buildbucket for the build status
[07:48:22.197] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:22.197] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:139:0) after 1m0s
[07:49:22.221] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:139:0)
[07:49:22.221] Timer tick, asking Buildbucket for the build status
[07:49:22.297] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:22.297] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:140:0) after 1m0s
[07:50:22.357] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:140:0)
[07:50:22.357] Timer tick, asking Buildbucket for the build status
[07:50:22.664] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:22.664] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:141:0) after 1m0s
[07:51:22.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:141:0)
[07:51:22.750] Timer tick, asking Buildbucket for the build status
[07:51:22.814] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:22.814] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:142:0) after 1m0s
[07:52:22.873] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:142:0)
[07:52:22.873] Timer tick, asking Buildbucket for the build status
[07:52:22.972] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:22.972] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:143:0) after 1m0s
[07:53:23.378] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:143:0)
[07:53:23.378] Timer tick, asking Buildbucket for the build status
[07:53:23.439] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:23.439] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:144:0) after 1m0s
[07:54:23.479] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:144:0)
[07:54:23.479] Timer tick, asking Buildbucket for the build status
[07:54:23.537] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:23.537] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:145:0) after 1m0s
[07:55:23.635] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:145:0)
[07:55:23.635] Timer tick, asking Buildbucket for the build status
[07:55:23.803] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:23.803] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:146:0) after 1m0s
[07:56:23.789] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:146:0)
[07:56:23.789] Timer tick, asking Buildbucket for the build status
[07:56:23.868] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:23.868] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:147:0) after 1m0s
[07:57:23.881] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:147:0)
[07:57:23.881] Timer tick, asking Buildbucket for the build status
[07:57:24.126] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:24.126] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:148:0) after 1m0s
[07:58:24.162] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:148:0)
[07:58:24.162] Timer tick, asking Buildbucket for the build status
[07:58:24.237] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:24.237] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:149:0) after 1m0s
[07:59:24.261] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:149:0)
[07:59:24.261] Timer tick, asking Buildbucket for the build status
[07:59:24.324] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:24.324] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:150:0) after 1m0s
[08:00:24.409] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:150:0)
[08:00:24.410] Timer tick, asking Buildbucket for the build status
[08:00:24.716] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:24.716] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:151:0) after 1m0s
[08:01:24.750] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:151:0)
[08:01:24.750] Timer tick, asking Buildbucket for the build status
[08:01:24.842] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:24.842] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:152:0) after 1m0s
[08:02:24.937] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:152:0)
[08:02:24.937] Timer tick, asking Buildbucket for the build status
[08:02:25.038] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:25.038] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:153:0) after 1m0s
[08:03:25.019] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:153:0)
[08:03:25.019] Timer tick, asking Buildbucket for the build status
[08:03:25.242] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:25.242] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:154:0) after 1m0s
[08:04:25.279] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:154:0)
[08:04:25.279] Timer tick, asking Buildbucket for the build status
[08:04:25.564] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:25.564] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:155:0) after 1m0s
[08:05:25.603] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:155:0)
[08:05:25.603] Timer tick, asking Buildbucket for the build status
[08:05:25.668] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:25.668] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:156:0) after 1m0s
[08:06:25.696] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:156:0)
[08:06:25.696] Timer tick, asking Buildbucket for the build status
[08:06:25.890] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:25.890] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:157:0) after 1m0s
[08:07:25.915] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:157:0)
[08:07:25.915] Timer tick, asking Buildbucket for the build status
[08:07:26.530] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:26.530] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:158:0) after 1m0s
[08:08:26.560] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:158:0)
[08:08:26.560] Timer tick, asking Buildbucket for the build status
[08:08:26.857] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:26.857] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:159:0) after 1m0s
[08:09:27.147] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:159:0)
[08:09:27.147] Timer tick, asking Buildbucket for the build status
[08:09:27.262] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:27.262] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:160:0) after 1m0s
[08:10:27.310] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:160:0)
[08:10:27.310] Timer tick, asking Buildbucket for the build status
[08:10:27.378] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:27.378] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:161:0) after 1m0s
[08:11:27.464] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:161:0)
[08:11:27.464] Timer tick, asking Buildbucket for the build status
[08:11:27.630] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:27.630] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:162:0) after 1m0s
[08:12:27.687] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:162:0)
[08:12:27.687] Timer tick, asking Buildbucket for the build status
[08:12:27.807] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:27.807] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:163:0) after 1m0s
[08:13:27.854] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:163:0)
[08:13:27.854] Timer tick, asking Buildbucket for the build status
[08:13:28.052] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:28.052] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:164:0) after 1m0s
[08:14:28.176] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:164:0)
[08:14:28.176] Timer tick, asking Buildbucket for the build status
[08:14:28.270] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:28.270] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:165:0) after 1m0s
[08:15:28.317] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:165:0)
[08:15:28.317] Timer tick, asking Buildbucket for the build status
[08:15:28.734] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:28.734] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:166:0) after 1m0s
[08:16:28.758] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:166:0)
[08:16:28.758] Timer tick, asking Buildbucket for the build status
[08:16:29.004] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:29.004] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:167:0) after 1m0s
[08:17:29.018] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:167:0)
[08:17:29.018] Timer tick, asking Buildbucket for the build status
[08:17:29.310] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:29.310] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:168:0) after 1m0s
[08:18:29.345] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:168:0)
[08:18:29.345] Timer tick, asking Buildbucket for the build status
[08:18:29.410] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:29.410] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:169:0) after 1m0s
[08:19:29.488] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:169:0)
[08:19:29.488] Timer tick, asking Buildbucket for the build status
[08:19:30.134] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:30.134] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:170:0) after 1m0s
[08:20:30.224] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:170:0)
[08:20:30.224] Timer tick, asking Buildbucket for the build status
[08:20:30.417] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:30.417] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:171:0) after 1m0s
[08:21:30.446] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:171:0)
[08:21:30.446] Timer tick, asking Buildbucket for the build status
[08:21:30.614] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:172:0) after 1m0s
[08:22:30.671] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:172:0)
[08:22:30.671] Timer tick, asking Buildbucket for the build status
[08:22:30.887] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:30.887] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:173:0) after 1m0s
[08:23:30.963] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:173:0)
[08:23:30.963] Timer tick, asking Buildbucket for the build status
[08:23:31.036] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:31.036] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:174:0) after 1m0s
[08:24:31.060] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:174:0)
[08:24:31.060] Timer tick, asking Buildbucket for the build status
[08:24:31.138] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:31.138] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:175:0) after 1m0s
[08:25:31.227] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:175:0)
[08:25:31.227] Timer tick, asking Buildbucket for the build status
[08:25:31.301] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:31.301] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:176:0) after 1m0s
[08:26:31.453] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:176:0)
[08:26:31.453] Timer tick, asking Buildbucket for the build status
[08:26:31.522] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:31.522] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:177:0) after 1m0s
[08:27:31.639] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:177:0)
[08:27:31.639] Timer tick, asking Buildbucket for the build status
[08:27:31.742] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:31.742] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:178:0) after 1m0s
[08:28:31.805] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:178:0)
[08:28:31.805] Timer tick, asking Buildbucket for the build status
[08:28:31.865] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:31.865] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:179:0) after 1m0s
[08:29:32.024] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:179:0)
[08:29:32.024] Timer tick, asking Buildbucket for the build status
[08:29:32.185] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:32.185] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:180:0) after 1m0s
[08:30:32.211] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:180:0)
[08:30:32.211] Timer tick, asking Buildbucket for the build status
[08:30:32.329] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:181:0) after 1m0s
[08:31:32.407] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:181:0)
[08:31:32.407] Timer tick, asking Buildbucket for the build status
[08:31:32.485] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:32.485] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:182:0) after 1m0s
[08:32:32.563] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:182:0)
[08:32:32.563] Timer tick, asking Buildbucket for the build status
[08:32:32.863] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:32.863] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:183:0) after 1m0s
[08:33:32.961] Handling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:183:0)
[08:33:32.961] Timer tick, asking Buildbucket for the build status
[08:33:33.122] Build 8856524048630143440: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:33.122] Scheduling timer "check-buildbucket-build-status" (chromium/win32-official:9021954110894240400:184:0) after 1m0s
[08:34:09.098] Received PubSub notification, asking Buildbucket for the build status
[08:34:09.158] Build 8856524048630143440: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:34:09.158] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612168448397443",
"created_by": "project:chromium",
"created_ts": "1612157504395005",
"id": "8856524048630143440",
"parameters_json": "{\"builder_name\": \"win32-official\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\"}}",
"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\": \"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\", \"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-05r0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium\", \"buildername\": \"win32-official\", \"buildnumber\": 1457, \"got_angle_revision\": \"0be050a44a4308ace01229b89bd4560457356007\", \"got_dawn_revision\": \"c1d3a66bd217395a501543b09c6d2c25e9d2e22e\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\", \"got_revision_cp\": \"refs/heads/master@{#849000}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8b4cf1c2491d56cf9eda153b5455e4b295732b7c\", \"got_v8_revision\": \"6069442cab5b767e9722d20cabda6d4864fb7210\", \"got_v8_revision_cp\": \"refs/heads/9.0.102@{#1}\", \"got_webrtc_revision\": \"41bfcf4a63611409220fcd458a03deaa2cd23619\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33116}\", \"mirrored_builders\": [\"tryserver.chromium:win32-official\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c0158802ae4c09fd9e998b43c45d71cd41f00bf4\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"win-archive-dbg\", \"win-archive-rel\", \"win-official\", \"win32-archive-dbg\", \"win32-archive-rel\", \"win32-official\"], \"caches\": [\"builder_524f8de60e2e268c779ae418ab45c03e275f35b08b0301b32216fe5285dcafcd_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"win-dbg-3-05r0\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"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\": [\"5673-2413400\"], \"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": "1612157526944456",
"status": "COMPLETED",
"status_changed_ts": "1612168448734801",
"tags": [
"build_address:luci.chromium.ci/win32-official/1457",
"builder:win32-official",
"buildset:commit/git/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c0158802ae4c09fd9e998b43c45d71cd41f00bf4",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021954110894240400",
"scheduler_job_id:chromium/win32-official",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8856524048630143440/+/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:5174e4dc9c510510",
"user_agent:luci-scheduler"
],
"updated_ts": "1612168448738962",
"url": "https://ci.chromium.org/b/8856524048630143440",
"utcnow_ts": "1612168449151202"
}
}
[08:34:09.158] Invocation finished in 3h2m26.306612799s with status SUCCEEDED