[15:45:46.275] New invocation is queued and will start shortly
[15:45:47.440] Starting the invocation (attempt 1)
[15:45:47.491] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[15:45:47.496] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[15:45:47.496] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020284732386651728",
"parameters_json": "{\"builder_name\":\"ToTWin(dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWin(dbg)",
"scheduler_invocation_id:9020284732386651728",
"scheduler_job_id:chromium/ToTWin(dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"gitiles_ref:refs/heads/master"
]
}
[15:45:48.659] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613749547646716",
"id": "8854854670285654992",
"parameters_json": "{\"builder_name\": \"ToTWin(dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613749548354217",
"tags": [
"build_address:luci.chromium.ci/ToTWin(dbg)/6732",
"builder:ToTWin(dbg)",
"buildset:commit/git/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020284732386651728",
"scheduler_job_id:chromium/ToTWin(dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854854670285654992/+/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": "1613749548354325",
"url": "https://ci.chromium.org/b/8854854670285654992",
"utcnow_ts": "1613749548614360"
}
}
[15:45:48.659] Task URL: https://ci.chromium.org/b/8854854670285654992
[15:45:48.659] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:2:0) after 1m0s
[15:46:24.893] Received PubSub notification, asking Buildbucket for the build status
[15:46:24.955] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:48.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:2:0)
[15:46:48.678] Timer tick, asking Buildbucket for the build status
[15:46:48.743] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:48.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:4:0) after 1m0s
[15:47:48.740] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:4:0)
[15:47:48.740] Timer tick, asking Buildbucket for the build status
[15:47:48.836] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:48.836] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:5:0) after 1m0s
[15:48:48.880] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:5:0)
[15:48:48.880] Timer tick, asking Buildbucket for the build status
[15:48:48.953] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:48.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:6:0) after 1m0s
[15:49:49.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:6:0)
[15:49:49.000] Timer tick, asking Buildbucket for the build status
[15:49:49.067] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:49.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:7:0) after 1m0s
[15:50:49.052] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:7:0)
[15:50:49.052] Timer tick, asking Buildbucket for the build status
[15:50:49.121] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:49.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:8:0) after 1m0s
[15:51:49.122] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:8:0)
[15:51:49.122] Timer tick, asking Buildbucket for the build status
[15:51:49.996] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:49.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:9:0) after 1m0s
[15:52:50.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:9:0)
[15:52:50.064] Timer tick, asking Buildbucket for the build status
[15:52:50.284] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:50.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:10:0) after 1m0s
[15:53:50.301] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:10:0)
[15:53:50.301] Timer tick, asking Buildbucket for the build status
[15:53:50.355] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:50.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:11:0) after 1m0s
[15:54:50.373] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:11:0)
[15:54:50.373] Timer tick, asking Buildbucket for the build status
[15:54:50.435] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:50.435] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:12:0) after 1m0s
[15:55:50.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:12:0)
[15:55:50.460] Timer tick, asking Buildbucket for the build status
[15:55:50.521] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:50.521] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:13:0) after 1m0s
[15:56:50.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:13:0)
[15:56:50.631] Timer tick, asking Buildbucket for the build status
[15:56:50.916] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:50.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:14:0) after 1m0s
[15:57:51.064] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:14:0)
[15:57:51.064] Timer tick, asking Buildbucket for the build status
[15:57:51.200] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:15:0) after 1m0s
[15:58:51.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:15:0)
[15:58:51.232] Timer tick, asking Buildbucket for the build status
[15:58:51.298] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:51.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:16:0) after 1m0s
[15:59:51.382] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:16:0)
[15:59:51.382] Timer tick, asking Buildbucket for the build status
[15:59:51.528] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:51.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:17:0) after 1m0s
[16:00:51.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:17:0)
[16:00:51.621] Timer tick, asking Buildbucket for the build status
[16:00:51.800] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:51.800] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:18:0) after 1m0s
[16:01:51.872] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:18:0)
[16:01:51.872] Timer tick, asking Buildbucket for the build status
[16:01:52.051] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:52.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:19:0) after 1m0s
[16:02:52.081] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:19:0)
[16:02:52.081] Timer tick, asking Buildbucket for the build status
[16:02:52.153] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:52.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:20:0) after 1m0s
[16:03:52.191] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:20:0)
[16:03:52.191] Timer tick, asking Buildbucket for the build status
[16:03:52.271] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:52.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:21:0) after 1m0s
[16:04:52.301] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:21:0)
[16:04:52.301] Timer tick, asking Buildbucket for the build status
[16:04:52.426] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:52.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:22:0) after 1m0s
[16:05:52.507] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:22:0)
[16:05:52.507] Timer tick, asking Buildbucket for the build status
[16:05:52.626] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:52.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:23:0) after 1m0s
[16:06:52.674] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:23:0)
[16:06:52.674] Timer tick, asking Buildbucket for the build status
[16:06:52.759] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:52.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:24:0) after 1m0s
[16:07:52.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:24:0)
[16:07:52.808] Timer tick, asking Buildbucket for the build status
[16:07:52.869] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:52.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:25:0) after 1m0s
[16:08:52.924] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:25:0)
[16:08:52.924] Timer tick, asking Buildbucket for the build status
[16:08:52.989] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:52.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:26:0) after 1m0s
[16:09:52.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:26:0)
[16:09:52.986] Timer tick, asking Buildbucket for the build status
[16:09:53.149] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:53.149] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:27:0) after 1m0s
[16:10:53.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:27:0)
[16:10:53.217] Timer tick, asking Buildbucket for the build status
[16:10:53.404] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:53.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:28:0) after 1m0s
[16:11:53.449] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:28:0)
[16:11:53.449] Timer tick, asking Buildbucket for the build status
[16:11:53.729] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:53.729] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:29:0) after 1m0s
[16:12:53.789] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:29:0)
[16:12:53.789] Timer tick, asking Buildbucket for the build status
[16:12:53.863] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:53.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:30:0) after 1m0s
[16:13:53.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:30:0)
[16:13:53.910] Timer tick, asking Buildbucket for the build status
[16:13:54.007] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:54.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:31:0) after 1m0s
[16:14:54.062] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:31:0)
[16:14:54.062] Timer tick, asking Buildbucket for the build status
[16:14:54.124] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:54.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:32:0) after 1m0s
[16:15:54.219] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:32:0)
[16:15:54.219] Timer tick, asking Buildbucket for the build status
[16:15:54.293] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:54.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:33:0) after 1m0s
[16:16:54.341] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:33:0)
[16:16:54.341] Timer tick, asking Buildbucket for the build status
[16:16:54.480] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:54.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:34:0) after 1m0s
[16:17:54.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:34:0)
[16:17:54.539] Timer tick, asking Buildbucket for the build status
[16:17:54.619] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:54.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:35:0) after 1m0s
[16:18:54.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:35:0)
[16:18:54.585] Timer tick, asking Buildbucket for the build status
[16:18:54.657] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:54.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:36:0) after 1m0s
[16:19:54.709] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:36:0)
[16:19:54.709] Timer tick, asking Buildbucket for the build status
[16:19:54.957] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:54.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:37:0) after 1m0s
[16:20:55.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:37:0)
[16:20:55.045] Timer tick, asking Buildbucket for the build status
[16:20:55.126] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:55.126] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:38:0) after 1m0s
[16:21:55.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:38:0)
[16:21:55.181] Timer tick, asking Buildbucket for the build status
[16:21:55.561] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:55.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:39:0) after 1m0s
[16:22:55.631] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:39:0)
[16:22:55.631] Timer tick, asking Buildbucket for the build status
[16:22:55.740] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:55.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:40:0) after 1m0s
[16:23:55.760] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:40:0)
[16:23:55.760] Timer tick, asking Buildbucket for the build status
[16:23:55.842] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:55.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:41:0) after 1m0s
[16:24:55.985] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:41:0)
[16:24:55.985] Timer tick, asking Buildbucket for the build status
[16:24:56.067] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:56.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:42:0) after 1m0s
[16:25:56.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:42:0)
[16:25:56.103] Timer tick, asking Buildbucket for the build status
[16:25:56.270] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:56.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:43:0) after 1m0s
[16:26:56.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:43:0)
[16:26:56.324] Timer tick, asking Buildbucket for the build status
[16:26:56.477] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:56.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:44:0) after 1m0s
[16:27:56.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:44:0)
[16:27:56.502] Timer tick, asking Buildbucket for the build status
[16:27:56.607] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:56.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:45:0) after 1m0s
[16:28:56.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:45:0)
[16:28:56.629] Timer tick, asking Buildbucket for the build status
[16:28:56.742] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:56.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:46:0) after 1m0s
[16:29:56.771] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:46:0)
[16:29:56.771] Timer tick, asking Buildbucket for the build status
[16:29:57.158] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:57.158] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:47:0) after 1m0s
[16:30:57.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:47:0)
[16:30:57.179] Timer tick, asking Buildbucket for the build status
[16:30:57.275] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:57.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:48:0) after 1m0s
[16:31:58.553] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:48:0)
[16:31:58.553] Timer tick, asking Buildbucket for the build status
[16:31:58.655] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:58.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:49:0) after 1m0s
[16:32:58.674] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:49:0)
[16:32:58.674] Timer tick, asking Buildbucket for the build status
[16:32:58.830] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:58.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:50:0) after 1m0s
[16:33:58.852] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:50:0)
[16:33:58.852] Timer tick, asking Buildbucket for the build status
[16:33:58.914] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:58.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:51:0) after 1m0s
[16:34:59.001] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:51:0)
[16:34:59.001] Timer tick, asking Buildbucket for the build status
[16:34:59.071] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:59.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:52:0) after 1m0s
[16:35:59.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:52:0)
[16:35:59.107] Timer tick, asking Buildbucket for the build status
[16:35:59.528] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:59.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:53:0) after 1m0s
[16:36:59.527] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:53:0)
[16:36:59.527] Timer tick, asking Buildbucket for the build status
[16:36:59.605] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:59.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:54:0) after 1m0s
[16:37:59.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:54:0)
[16:37:59.662] Timer tick, asking Buildbucket for the build status
[16:37:59.743] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:59.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:55:0) after 1m0s
[16:39:01.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:55:0)
[16:39:01.713] Timer tick, asking Buildbucket for the build status
[16:39:02.111] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:02.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:56:0) after 1m0s
[16:40:02.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:56:0)
[16:40:02.112] Timer tick, asking Buildbucket for the build status
[16:40:02.227] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:02.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:57:0) after 1m0s
[16:41:02.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:57:0)
[16:41:02.297] Timer tick, asking Buildbucket for the build status
[16:41:02.368] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:02.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:58:0) after 1m0s
[16:42:02.415] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:58:0)
[16:42:02.415] Timer tick, asking Buildbucket for the build status
[16:42:02.536] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:02.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:59:0) after 1m0s
[16:43:02.537] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:59:0)
[16:43:02.537] Timer tick, asking Buildbucket for the build status
[16:43:02.899] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:02.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:60:0) after 1m0s
[16:44:03.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:60:0)
[16:44:03.048] Timer tick, asking Buildbucket for the build status
[16:44:03.467] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:03.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:61:0) after 1m0s
[16:45:03.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:61:0)
[16:45:03.594] Timer tick, asking Buildbucket for the build status
[16:45:03.864] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:03.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:62:0) after 1m0s
[16:46:03.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:62:0)
[16:46:03.935] Timer tick, asking Buildbucket for the build status
[16:46:04.028] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:04.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:63:0) after 1m0s
[16:47:04.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:63:0)
[16:47:04.048] Timer tick, asking Buildbucket for the build status
[16:47:04.209] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:04.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:64:0) after 1m0s
[16:48:04.264] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:64:0)
[16:48:04.264] Timer tick, asking Buildbucket for the build status
[16:48:04.371] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:04.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:65:0) after 1m0s
[16:49:04.656] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:65:0)
[16:49:04.656] Timer tick, asking Buildbucket for the build status
[16:49:04.793] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:04.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:66:0) after 1m0s
[16:50:04.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:66:0)
[16:50:04.886] Timer tick, asking Buildbucket for the build status
[16:50:04.945] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:04.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:67:0) after 1m0s
[16:51:05.258] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:67:0)
[16:51:05.258] Timer tick, asking Buildbucket for the build status
[16:51:05.355] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:05.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:68:0) after 1m0s
[16:52:05.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:68:0)
[16:52:05.570] Timer tick, asking Buildbucket for the build status
[16:52:05.638] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:05.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:69:0) after 1m0s
[16:53:05.758] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:69:0)
[16:53:05.758] Timer tick, asking Buildbucket for the build status
[16:53:05.868] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:05.868] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:70:0) after 1m0s
[16:54:06.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:70:0)
[16:54:06.554] Timer tick, asking Buildbucket for the build status
[16:54:06.619] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:06.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:71:0) after 1m0s
[16:55:06.753] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:71:0)
[16:55:06.753] Timer tick, asking Buildbucket for the build status
[16:55:06.942] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:06.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:72:0) after 1m0s
[16:56:07.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:72:0)
[16:56:07.110] Timer tick, asking Buildbucket for the build status
[16:56:07.202] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:07.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:73:0) after 1m0s
[16:57:07.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:73:0)
[16:57:07.316] Timer tick, asking Buildbucket for the build status
[16:57:07.421] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:07.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:74:0) after 1m0s
[16:58:07.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:74:0)
[16:58:07.749] Timer tick, asking Buildbucket for the build status
[16:58:07.839] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:07.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:75:0) after 1m0s
[16:59:08.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:75:0)
[16:59:08.215] Timer tick, asking Buildbucket for the build status
[16:59:08.293] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:08.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:76:0) after 1m0s
[17:00:08.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:76:0)
[17:00:08.802] Timer tick, asking Buildbucket for the build status
[17:00:08.940] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:08.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:77:0) after 1m0s
[17:01:09.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:77:0)
[17:01:09.275] Timer tick, asking Buildbucket for the build status
[17:01:09.381] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:09.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:78:0) after 1m0s
[17:02:09.459] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:78:0)
[17:02:09.459] Timer tick, asking Buildbucket for the build status
[17:02:09.634] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:09.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:79:0) after 1m0s
[17:03:09.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:79:0)
[17:03:09.705] Timer tick, asking Buildbucket for the build status
[17:03:09.832] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:09.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:80:0) after 1m0s
[17:04:09.949] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:80:0)
[17:04:09.949] Timer tick, asking Buildbucket for the build status
[17:04:10.043] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:10.043] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:81:0) after 1m0s
[17:05:10.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:81:0)
[17:05:10.112] Timer tick, asking Buildbucket for the build status
[17:05:10.250] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:10.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:82:0) after 1m0s
[17:06:11.661] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:82:0)
[17:06:11.661] Timer tick, asking Buildbucket for the build status
[17:06:11.771] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:11.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:83:0) after 1m0s
[17:07:11.881] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:83:0)
[17:07:11.881] Timer tick, asking Buildbucket for the build status
[17:07:11.962] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:11.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:84:0) after 1m0s
[17:08:11.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:84:0)
[17:08:11.969] Timer tick, asking Buildbucket for the build status
[17:08:12.068] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:12.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:85:0) after 1m0s
[17:09:12.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:85:0)
[17:09:12.116] Timer tick, asking Buildbucket for the build status
[17:09:12.186] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:12.186] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:86:0) after 1m0s
[17:10:12.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:86:0)
[17:10:12.211] Timer tick, asking Buildbucket for the build status
[17:10:12.528] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:12.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:87:0) after 1m0s
[17:11:12.639] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:87:0)
[17:11:12.639] Timer tick, asking Buildbucket for the build status
[17:11:12.730] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:12.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:88:0) after 1m0s
[17:12:12.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:88:0)
[17:12:12.828] Timer tick, asking Buildbucket for the build status
[17:12:13.205] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:13.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:89:0) after 1m0s
[17:13:13.356] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:89:0)
[17:13:13.356] Timer tick, asking Buildbucket for the build status
[17:13:13.432] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:13.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:90:0) after 1m0s
[17:14:13.655] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:90:0)
[17:14:13.655] Timer tick, asking Buildbucket for the build status
[17:14:13.732] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:13.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:91:0) after 1m0s
[17:15:13.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:91:0)
[17:15:13.884] Timer tick, asking Buildbucket for the build status
[17:15:14.046] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:14.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:92:0) after 1m0s
[17:16:14.066] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:92:0)
[17:16:14.066] Timer tick, asking Buildbucket for the build status
[17:16:14.174] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:14.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:93:0) after 1m0s
[17:17:14.229] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:93:0)
[17:17:14.229] Timer tick, asking Buildbucket for the build status
[17:17:14.296] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:14.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:94:0) after 1m0s
[17:18:14.380] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:94:0)
[17:18:14.380] Timer tick, asking Buildbucket for the build status
[17:18:14.459] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:14.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:95:0) after 1m0s
[17:19:14.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:95:0)
[17:19:14.623] Timer tick, asking Buildbucket for the build status
[17:19:14.690] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:14.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:96:0) after 1m0s
[17:20:14.804] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:96:0)
[17:20:14.804] Timer tick, asking Buildbucket for the build status
[17:20:14.879] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:14.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:97:0) after 1m0s
[17:21:14.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:97:0)
[17:21:14.909] Timer tick, asking Buildbucket for the build status
[17:21:15.144] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:15.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:98:0) after 1m0s
[17:22:15.164] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:98:0)
[17:22:15.164] Timer tick, asking Buildbucket for the build status
[17:22:15.261] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:15.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:99:0) after 1m0s
[17:23:15.356] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:99:0)
[17:23:15.356] Timer tick, asking Buildbucket for the build status
[17:23:15.456] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:15.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:100:0) after 1m0s
[17:24:15.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:100:0)
[17:24:15.569] Timer tick, asking Buildbucket for the build status
[17:24:15.638] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:15.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:101:0) after 1m0s
[17:25:15.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:101:0)
[17:25:15.682] Timer tick, asking Buildbucket for the build status
[17:25:15.754] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:15.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:102:0) after 1m0s
[17:26:15.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:102:0)
[17:26:15.851] Timer tick, asking Buildbucket for the build status
[17:26:15.940] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:15.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:103:0) after 1m0s
[17:27:16.003] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:103:0)
[17:27:16.004] Timer tick, asking Buildbucket for the build status
[17:27:16.084] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:16.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:104:0) after 1m0s
[17:28:16.804] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:104:0)
[17:28:16.804] Timer tick, asking Buildbucket for the build status
[17:28:16.973] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:16.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:105:0) after 1m0s
[17:29:17.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:105:0)
[17:29:17.127] Timer tick, asking Buildbucket for the build status
[17:29:17.589] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:17.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:106:0) after 1m0s
[17:30:17.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:106:0)
[17:30:17.827] Timer tick, asking Buildbucket for the build status
[17:30:22.119] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:22.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:107:0) after 1m0s
[17:31:22.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:107:0)
[17:31:22.374] Timer tick, asking Buildbucket for the build status
[17:31:22.488] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:22.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:108:0) after 1m0s
[17:32:22.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:108:0)
[17:32:22.637] Timer tick, asking Buildbucket for the build status
[17:32:22.758] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:22.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:109:0) after 1m0s
[17:33:23.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:109:0)
[17:33:23.025] Timer tick, asking Buildbucket for the build status
[17:33:23.133] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:23.133] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:110:0) after 1m0s
[17:34:23.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:110:0)
[17:34:23.245] Timer tick, asking Buildbucket for the build status
[17:34:23.349] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:23.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:111:0) after 1m0s
[17:35:23.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:111:0)
[17:35:23.508] Timer tick, asking Buildbucket for the build status
[17:35:23.578] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:23.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:112:0) after 1m0s
[17:36:23.732] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:112:0)
[17:36:23.732] Timer tick, asking Buildbucket for the build status
[17:36:23.831] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:23.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:113:0) after 1m0s
[17:37:23.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:113:0)
[17:37:23.976] Timer tick, asking Buildbucket for the build status
[17:37:24.127] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:24.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:114:0) after 1m0s
[17:38:24.318] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:114:0)
[17:38:24.318] Timer tick, asking Buildbucket for the build status
[17:38:24.389] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:24.389] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:115:0) after 1m0s
[17:39:24.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:115:0)
[17:39:24.451] Timer tick, asking Buildbucket for the build status
[17:39:24.580] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:24.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:116:0) after 1m0s
[17:40:24.621] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:116:0)
[17:40:24.621] Timer tick, asking Buildbucket for the build status
[17:40:24.694] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:24.694] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:117:0) after 1m0s
[17:41:24.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:117:0)
[17:41:24.812] Timer tick, asking Buildbucket for the build status
[17:41:24.889] Build 8854854670285654992: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:24.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9020284732386651728:118:0) after 1m0s
[17:42:14.594] Received PubSub notification, asking Buildbucket for the build status
[17:42:14.666] Build 8854854670285654992: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[17:42:14.666] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613756533498492",
"created_by": "project:chromium",
"created_ts": "1613749547646716",
"failure_reason": "BUILD_FAILURE",
"id": "8854854670285654992",
"parameters_json": "{\"builder_name\": \"ToTWin(dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[4905/110968] CXX win_clang_nacl_win64/obj/third_party/dawn/src/common/common/Result.obj\\nFAILED: win_clang_nacl_win64/obj/third_party/dawn/src/common/common/Result.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user /winsysroot...(too long)\\nerror: unknown warning option '-Wreturn-std-move-in-c++11'; did you mean '-Wreturn-std-move'? [-Werror,-Wunknown-warning-option]\\n[4908/110968] CXX win_clang_nacl_win64/obj/third_party/dawn/src/common/common/SlabAllocator.obj\\nFAILED: win_clang_nacl_win64/obj/third_party/dawn/src/common/common/SlabAllocator.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user /winsysroot...(too long)\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\", \"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\": \"luci-chromium-ci-win10-32-8-dv9l\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWin(dbg)\", \"buildnumber\": 6732, \"clang_revision\": \"llvmorg-13-init-2247-gc1653b8c-0\", \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"4ad2ff292145e8613ec371302875f0eaf8b4fa14\", \"got_revision\": \"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\", \"got_revision_cp\": \"refs/heads/master@{#855699}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_02613bacee8cd1c41158238da4ce7615021ecb28a4b52e6029f89cb601af0790_v2\", \"builder_32bcab4cf484e052115811812b759d41ea58513be642cb87501843a8f7df98a3_v2\", \"builder_a4ee364c4b5996d1649f16c77d7186222b75eb5b75762fbbe3baeec97aac12d9_v2\", \"builder_f77c1c08af9d0a4522ad60c9181aa925a8ae87fd7ec8443f284fb40f3b6bc27b_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-8-dv9l\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[4905/110968] CXX win_clang_nacl_win64/obj/third_party/dawn/src/common/common/Result.obj\\nFAILED: win_clang_nacl_win64/obj/third_party/dawn/src/common/common/Result.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user /winsysroot...(too long)\\nerror: unknown warning option '-Wreturn-std-move-in-c++11'; did you mean '-Wreturn-std-move'? [-Werror,-Wunknown-warning-option]\\n[4908/110968] CXX win_clang_nacl_win64/obj/third_party/dawn/src/common/common/SlabAllocator.obj\\nFAILED: win_clang_nacl_win64/obj/third_party/dawn/src/common/common/SlabAllocator.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user /winsysroot...(too long)\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613749583156700",
"status": "COMPLETED",
"status_changed_ts": "1613749583686348",
"tags": [
"build_address:luci.chromium.ci/ToTWin(dbg)/6732",
"builder:ToTWin(dbg)",
"buildset:commit/git/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/bb0ee924c4e6d4b970a7dcfd371e92bea5e4f08c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020284732386651728",
"scheduler_job_id:chromium/ToTWin(dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8854854670285654992/+/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:51d3c9a66ab4b510",
"user_agent:luci-scheduler"
],
"updated_ts": "1613756533634800",
"url": "https://ci.chromium.org/b/8854854670285654992",
"utcnow_ts": "1613756534659667"
}
}
[17:42:14.666] Invocation finished in 1h56m28.407510739s with status FAILED