[05:39:02.573] New invocation is queued and will start shortly
[05:39:03.721] Starting the invocation (attempt 1)
[05:39:03.782] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:39:03.782] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:39:03.783] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022859619494845632",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ca4d94f4782f12ec25903268188e771863d1dc1e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022859619494845632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/ca4d94f4782f12ec25903268188e771863d1dc1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca4d94f4782f12ec25903268188e771863d1dc1e",
"gitiles_ref:refs/heads/master"
]
}
[05:39:05.028] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611293943898198",
"id": "8857429557441440752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca4d94f4782f12ec25903268188e771863d1dc1e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611293944644609",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22297",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ca4d94f4782f12ec25903268188e771863d1dc1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca4d94f4782f12ec25903268188e771863d1dc1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022859619494845632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857429557441440752/+/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": "1611293944644723",
"url": "https://ci.chromium.org/b/8857429557441440752",
"utcnow_ts": "1611293945018692"
}
}
[05:39:05.028] Task URL: https://ci.chromium.org/b/8857429557441440752
[05:39:05.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:2:0) after 1m0s
[05:39:31.646] Received PubSub notification, asking Buildbucket for the build status
[05:39:31.728] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:05.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:2:0)
[05:40:05.348] Timer tick, asking Buildbucket for the build status
[05:40:05.710] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:05.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:4:0) after 1m0s
[05:41:05.825] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:4:0)
[05:41:05.825] Timer tick, asking Buildbucket for the build status
[05:41:05.955] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:05.955] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:5:0) after 1m0s
[05:42:06.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:5:0)
[05:42:06.028] Timer tick, asking Buildbucket for the build status
[05:42:06.136] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:06.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:6:0) after 1m0s
[05:43:06.207] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:6:0)
[05:43:06.207] Timer tick, asking Buildbucket for the build status
[05:43:06.352] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:06.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:7:0) after 1m0s
[05:44:06.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:7:0)
[05:44:06.363] Timer tick, asking Buildbucket for the build status
[05:44:06.513] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:06.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:8:0) after 1m0s
[05:45:06.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:8:0)
[05:45:06.583] Timer tick, asking Buildbucket for the build status
[05:45:07.535] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:07.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:9:0) after 1m0s
[05:46:07.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:9:0)
[05:46:07.688] Timer tick, asking Buildbucket for the build status
[05:46:07.923] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:07.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:10:0) after 1m0s
[05:47:07.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:10:0)
[05:47:07.970] Timer tick, asking Buildbucket for the build status
[05:47:08.085] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:08.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:11:0) after 1m0s
[05:48:08.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:11:0)
[05:48:08.263] Timer tick, asking Buildbucket for the build status
[05:48:08.341] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:08.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:12:0) after 1m0s
[05:49:08.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:12:0)
[05:49:08.371] Timer tick, asking Buildbucket for the build status
[05:49:08.829] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:08.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:13:0) after 1m0s
[05:50:08.898] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:13:0)
[05:50:08.898] Timer tick, asking Buildbucket for the build status
[05:50:09.200] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:09.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:14:0) after 1m0s
[05:51:09.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:14:0)
[05:51:09.221] Timer tick, asking Buildbucket for the build status
[05:51:09.512] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:09.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:15:0) after 1m0s
[05:52:09.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:15:0)
[05:52:09.571] Timer tick, asking Buildbucket for the build status
[05:52:10.003] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:10.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:16:0) after 1m0s
[05:53:10.105] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:16:0)
[05:53:10.105] Timer tick, asking Buildbucket for the build status
[05:53:10.260] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:10.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:17:0) after 1m0s
[05:54:10.445] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:17:0)
[05:54:10.445] Timer tick, asking Buildbucket for the build status
[05:54:10.709] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:10.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:18:0) after 1m0s
[05:55:10.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:18:0)
[05:55:10.834] Timer tick, asking Buildbucket for the build status
[05:55:10.908] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:10.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:19:0) after 1m0s
[05:56:10.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:19:0)
[05:56:10.983] Timer tick, asking Buildbucket for the build status
[05:56:11.209] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:11.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:20:0) after 1m0s
[05:57:11.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:20:0)
[05:57:11.300] Timer tick, asking Buildbucket for the build status
[05:57:11.362] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:11.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:21:0) after 1m0s
[05:58:11.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:21:0)
[05:58:11.429] Timer tick, asking Buildbucket for the build status
[05:58:11.497] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:11.497] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:22:0) after 1m0s
[05:59:11.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:22:0)
[05:59:11.490] Timer tick, asking Buildbucket for the build status
[05:59:11.615] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:11.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:23:0) after 1m0s
[06:00:11.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:23:0)
[06:00:11.708] Timer tick, asking Buildbucket for the build status
[06:00:13.229] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:13.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:24:0) after 1m0s
[06:01:14.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:24:0)
[06:01:14.951] Timer tick, asking Buildbucket for the build status
[06:01:15.032] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:15.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:25:0) after 1m0s
[06:02:15.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:25:0)
[06:02:15.038] Timer tick, asking Buildbucket for the build status
[06:02:15.100] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:15.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:26:0) after 1m0s
[06:03:15.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:26:0)
[06:03:15.194] Timer tick, asking Buildbucket for the build status
[06:03:15.327] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:15.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:27:0) after 1m0s
[06:04:15.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:27:0)
[06:04:15.397] Timer tick, asking Buildbucket for the build status
[06:04:15.566] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:15.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:28:0) after 1m0s
[06:05:15.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:28:0)
[06:05:15.660] Timer tick, asking Buildbucket for the build status
[06:05:15.722] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:15.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:29:0) after 1m0s
[06:06:15.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:29:0)
[06:06:15.758] Timer tick, asking Buildbucket for the build status
[06:06:15.894] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:15.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:30:0) after 1m0s
[06:07:15.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:30:0)
[06:07:15.986] Timer tick, asking Buildbucket for the build status
[06:07:16.109] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:16.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:31:0) after 1m0s
[06:08:16.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:31:0)
[06:08:16.227] Timer tick, asking Buildbucket for the build status
[06:08:16.289] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:16.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:32:0) after 1m0s
[06:09:16.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:32:0)
[06:09:16.480] Timer tick, asking Buildbucket for the build status
[06:09:16.962] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:16.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:33:0) after 1m0s
[06:10:17.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:33:0)
[06:10:17.059] Timer tick, asking Buildbucket for the build status
[06:10:17.226] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:17.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:34:0) after 1m0s
[06:11:17.327] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:34:0)
[06:11:17.327] Timer tick, asking Buildbucket for the build status
[06:11:17.699] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:17.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:35:0) after 1m0s
[06:12:17.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:35:0)
[06:12:17.795] Timer tick, asking Buildbucket for the build status
[06:12:17.852] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:17.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:36:0) after 1m0s
[06:13:17.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:36:0)
[06:13:17.910] Timer tick, asking Buildbucket for the build status
[06:13:18.605] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:18.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:37:0) after 1m0s
[06:14:18.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:37:0)
[06:14:18.640] Timer tick, asking Buildbucket for the build status
[06:14:18.947] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:18.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:38:0) after 1m0s
[06:15:19.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:38:0)
[06:15:19.001] Timer tick, asking Buildbucket for the build status
[06:15:19.256] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:19.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:39:0) after 1m0s
[06:16:19.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:39:0)
[06:16:19.267] Timer tick, asking Buildbucket for the build status
[06:16:19.541] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:19.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:40:0) after 1m0s
[06:17:19.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:40:0)
[06:17:19.585] Timer tick, asking Buildbucket for the build status
[06:17:19.655] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:17:19.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:41:0) after 1m0s
[06:18:19.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:41:0)
[06:18:19.702] Timer tick, asking Buildbucket for the build status
[06:18:19.889] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:18:19.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:42:0) after 1m0s
[06:19:19.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:42:0)
[06:19:19.971] Timer tick, asking Buildbucket for the build status
[06:19:20.104] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:19:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:43:0) after 1m0s
[06:20:20.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:43:0)
[06:20:20.104] Timer tick, asking Buildbucket for the build status
[06:20:20.165] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:20:20.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:44:0) after 1m0s
[06:21:20.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:44:0)
[06:21:20.187] Timer tick, asking Buildbucket for the build status
[06:21:20.248] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:20.248] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:45:0) after 1m0s
[06:22:20.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:45:0)
[06:22:20.271] Timer tick, asking Buildbucket for the build status
[06:22:20.512] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:20.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:46:0) after 1m0s
[06:23:20.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:46:0)
[06:23:20.508] Timer tick, asking Buildbucket for the build status
[06:23:20.724] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:20.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:47:0) after 1m0s
[06:24:20.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:47:0)
[06:24:20.767] Timer tick, asking Buildbucket for the build status
[06:24:21.062] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:21.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:48:0) after 1m0s
[06:25:21.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:48:0)
[06:25:21.083] Timer tick, asking Buildbucket for the build status
[06:25:21.399] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:21.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:49:0) after 1m0s
[06:26:21.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:49:0)
[06:26:21.452] Timer tick, asking Buildbucket for the build status
[06:26:21.575] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:21.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:50:0) after 1m0s
[06:27:21.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:50:0)
[06:27:21.737] Timer tick, asking Buildbucket for the build status
[06:27:21.966] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:21.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:51:0) after 1m0s
[06:28:21.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:51:0)
[06:28:21.975] Timer tick, asking Buildbucket for the build status
[06:28:22.264] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:22.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:52:0) after 1m0s
[06:29:22.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:52:0)
[06:29:22.323] Timer tick, asking Buildbucket for the build status
[06:29:22.423] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:22.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:53:0) after 1m0s
[06:30:22.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:53:0)
[06:30:22.482] Timer tick, asking Buildbucket for the build status
[06:30:23.791] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:23.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:54:0) after 1m0s
[06:31:23.813] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:54:0)
[06:31:23.813] Timer tick, asking Buildbucket for the build status
[06:31:23.889] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:23.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:55:0) after 1m0s
[06:32:23.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:55:0)
[06:32:23.910] Timer tick, asking Buildbucket for the build status
[06:32:24.289] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:24.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:56:0) after 1m0s
[06:33:24.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:56:0)
[06:33:24.285] Timer tick, asking Buildbucket for the build status
[06:33:24.399] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:24.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:57:0) after 1m0s
[06:34:24.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:57:0)
[06:34:24.413] Timer tick, asking Buildbucket for the build status
[06:34:24.592] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:24.592] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:58:0) after 1m0s
[06:35:24.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:58:0)
[06:35:24.642] Timer tick, asking Buildbucket for the build status
[06:35:24.767] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:24.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:59:0) after 1m0s
[06:36:24.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:59:0)
[06:36:24.828] Timer tick, asking Buildbucket for the build status
[06:36:24.947] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:24.947] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:60:0) after 1m0s
[06:37:25.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:60:0)
[06:37:25.066] Timer tick, asking Buildbucket for the build status
[06:37:25.649] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:25.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:61:0) after 1m0s
[06:38:25.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:61:0)
[06:38:25.697] Timer tick, asking Buildbucket for the build status
[06:38:26.072] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:26.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:62:0) after 1m0s
[06:39:26.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:62:0)
[06:39:26.159] Timer tick, asking Buildbucket for the build status
[06:39:26.269] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:26.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:63:0) after 1m0s
[06:40:26.307] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:63:0)
[06:40:26.307] Timer tick, asking Buildbucket for the build status
[06:40:26.431] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:26.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:64:0) after 1m0s
[06:41:26.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:64:0)
[06:41:26.521] Timer tick, asking Buildbucket for the build status
[06:41:27.295] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:27.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:65:0) after 1m0s
[06:42:27.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:65:0)
[06:42:27.502] Timer tick, asking Buildbucket for the build status
[06:42:28.005] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:28.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:66:0) after 1m0s
[06:43:28.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:66:0)
[06:43:28.143] Timer tick, asking Buildbucket for the build status
[06:43:28.278] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:28.278] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:67:0) after 1m0s
[06:44:28.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:67:0)
[06:44:28.427] Timer tick, asking Buildbucket for the build status
[06:44:28.620] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:28.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:68:0) after 1m0s
[06:45:28.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:68:0)
[06:45:28.762] Timer tick, asking Buildbucket for the build status
[06:45:28.853] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:28.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:69:0) after 1m0s
[06:46:28.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:69:0)
[06:46:28.997] Timer tick, asking Buildbucket for the build status
[06:46:29.439] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:29.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:70:0) after 1m0s
[06:47:29.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:70:0)
[06:47:29.566] Timer tick, asking Buildbucket for the build status
[06:47:29.973] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:29.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:71:0) after 1m0s
[06:48:30.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:71:0)
[06:48:30.034] Timer tick, asking Buildbucket for the build status
[06:48:30.116] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:30.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:72:0) after 1m0s
[06:49:30.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:72:0)
[06:49:30.202] Timer tick, asking Buildbucket for the build status
[06:49:30.634] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:30.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:73:0) after 1m0s
[06:50:30.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:73:0)
[06:50:30.657] Timer tick, asking Buildbucket for the build status
[06:50:31.074] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:31.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:74:0) after 1m0s
[06:51:31.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:74:0)
[06:51:31.186] Timer tick, asking Buildbucket for the build status
[06:51:31.306] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:31.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:75:0) after 1m0s
[06:52:31.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:75:0)
[06:52:31.362] Timer tick, asking Buildbucket for the build status
[06:52:31.491] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:76:0) after 1m0s
[06:53:31.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:76:0)
[06:53:31.627] Timer tick, asking Buildbucket for the build status
[06:53:32.043] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:32.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:77:0) after 1m0s
[06:54:32.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:77:0)
[06:54:32.153] Timer tick, asking Buildbucket for the build status
[06:54:32.313] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:32.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:78:0) after 1m0s
[06:55:32.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:78:0)
[06:55:32.393] Timer tick, asking Buildbucket for the build status
[06:55:33.076] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:33.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:79:0) after 1m0s
[06:56:33.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:79:0)
[06:56:33.156] Timer tick, asking Buildbucket for the build status
[06:56:33.230] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:33.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:80:0) after 1m0s
[06:57:36.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:80:0)
[06:57:36.566] Timer tick, asking Buildbucket for the build status
[06:57:36.760] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:36.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:81:0) after 1m0s
[06:58:36.808] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:81:0)
[06:58:36.808] Timer tick, asking Buildbucket for the build status
[06:58:36.949] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:36.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:82:0) after 1m0s
[06:59:37.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:82:0)
[06:59:37.505] Timer tick, asking Buildbucket for the build status
[06:59:37.642] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:37.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:83:0) after 1m0s
[07:00:37.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:83:0)
[07:00:37.770] Timer tick, asking Buildbucket for the build status
[07:00:37.893] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:37.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:84:0) after 1m0s
[07:01:38.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:84:0)
[07:01:38.131] Timer tick, asking Buildbucket for the build status
[07:01:38.212] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:38.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:85:0) after 1m0s
[07:02:38.236] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:85:0)
[07:02:38.236] Timer tick, asking Buildbucket for the build status
[07:02:38.511] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:38.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:86:0) after 1m0s
[07:03:38.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:86:0)
[07:03:38.572] Timer tick, asking Buildbucket for the build status
[07:03:38.831] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:38.831] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:87:0) after 1m0s
[07:04:38.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:87:0)
[07:04:38.895] Timer tick, asking Buildbucket for the build status
[07:04:38.997] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:38.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:88:0) after 1m0s
[07:05:39.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:88:0)
[07:05:39.098] Timer tick, asking Buildbucket for the build status
[07:05:39.320] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:39.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:89:0) after 1m0s
[07:06:39.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:89:0)
[07:06:39.344] Timer tick, asking Buildbucket for the build status
[07:06:39.627] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:39.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:90:0) after 1m0s
[07:07:39.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:90:0)
[07:07:39.727] Timer tick, asking Buildbucket for the build status
[07:07:39.802] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:39.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:91:0) after 1m0s
[07:08:39.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:91:0)
[07:08:39.836] Timer tick, asking Buildbucket for the build status
[07:08:40.462] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:40.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:92:0) after 1m0s
[07:09:40.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:92:0)
[07:09:40.558] Timer tick, asking Buildbucket for the build status
[07:09:40.698] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:40.698] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:93:0) after 1m0s
[07:10:40.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:93:0)
[07:10:40.757] Timer tick, asking Buildbucket for the build status
[07:10:40.851] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:40.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:94:0) after 1m0s
[07:11:40.913] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:94:0)
[07:11:40.913] Timer tick, asking Buildbucket for the build status
[07:11:40.974] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:40.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:95:0) after 1m0s
[07:12:41.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:95:0)
[07:12:41.085] Timer tick, asking Buildbucket for the build status
[07:12:41.185] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:41.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:96:0) after 1m0s
[07:13:41.305] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:96:0)
[07:13:41.305] Timer tick, asking Buildbucket for the build status
[07:13:41.441] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:41.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:97:0) after 1m0s
[07:14:41.535] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:97:0)
[07:14:41.535] Timer tick, asking Buildbucket for the build status
[07:14:41.689] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:41.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:98:0) after 1m0s
[07:15:41.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:98:0)
[07:15:41.738] Timer tick, asking Buildbucket for the build status
[07:15:42.226] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:42.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:99:0) after 1m0s
[07:16:42.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:99:0)
[07:16:42.427] Timer tick, asking Buildbucket for the build status
[07:16:42.726] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:42.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:100:0) after 1m0s
[07:17:42.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:100:0)
[07:17:42.773] Timer tick, asking Buildbucket for the build status
[07:17:43.106] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:43.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:101:0) after 1m0s
[07:18:43.106] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:101:0)
[07:18:43.106] Timer tick, asking Buildbucket for the build status
[07:18:43.493] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:43.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:102:0) after 1m0s
[07:19:43.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:102:0)
[07:19:43.532] Timer tick, asking Buildbucket for the build status
[07:19:44.303] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:44.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:103:0) after 1m0s
[07:20:44.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:103:0)
[07:20:44.372] Timer tick, asking Buildbucket for the build status
[07:20:44.711] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:44.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:104:0) after 1m0s
[07:21:44.754] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:104:0)
[07:21:44.754] Timer tick, asking Buildbucket for the build status
[07:21:45.363] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:45.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:105:0) after 1m0s
[07:22:45.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:105:0)
[07:22:45.479] Timer tick, asking Buildbucket for the build status
[07:22:45.561] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:45.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:106:0) after 1m0s
[07:23:45.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:106:0)
[07:23:45.648] Timer tick, asking Buildbucket for the build status
[07:23:46.276] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:46.276] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:107:0) after 1m0s
[07:24:46.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:107:0)
[07:24:46.386] Timer tick, asking Buildbucket for the build status
[07:24:46.538] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:46.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:108:0) after 1m0s
[07:25:46.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:108:0)
[07:25:46.565] Timer tick, asking Buildbucket for the build status
[07:25:46.861] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:46.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:109:0) after 1m0s
[07:26:46.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:109:0)
[07:26:46.940] Timer tick, asking Buildbucket for the build status
[07:26:47.160] Build 8857429557441440752: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:47.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022859619494845632:110:0) after 1m0s
[07:27:27.389] Received PubSub notification, asking Buildbucket for the build status
[07:27:27.712] Build 8857429557441440752: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:27:27.712] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611300445489852",
"created_by": "project:chromium",
"created_ts": "1611293943898198",
"id": "8857429557441440752",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca4d94f4782f12ec25903268188e771863d1dc1e\"}}",
"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\": \"ca4d94f4782f12ec25903268188e771863d1dc1e\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-89-mvey\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22297, \"got_angle_revision\": \"ff5f715e5c4af1f2195da69c4b7bb03efa5a91f8\", \"got_dawn_revision\": \"b5cfe3a7746c59903d3fe216e3876cb80c1d71c7\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"ca4d94f4782f12ec25903268188e771863d1dc1e\", \"got_revision_cp\": \"refs/heads/master@{#845963}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"12aab80c26a578c53de9ed111745f2cd8b55912f\", \"got_v8_revision_cp\": \"refs/heads/9.0.44@{#1}\", \"got_webrtc_revision\": \"e4fd1ba3198932d4c4ca0e0cc98635758555adee\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33053}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca4d94f4782f12ec25903268188e771863d1dc1e\", \"swarm_hashes_refs/heads/master(at){#845963}_without_patch\": {\"absl_hardening_tests\": \"ac5042ae726c2ed951479c4ed781859103f321de\", \"accessibility_unittests\": \"9e6cf78aaaf12f00fa768e85366602d453b0e691\", \"angle_unittests\": \"25116b110145ed32a8a51dd4fdd6426a3d114dbc\", \"app_list_unittests\": \"bb6cbc3647eaca4ccc959b251c7555d84d7d444b\", \"app_shell_unittests\": \"5c4fe1848aa480ae0e9c6cc7fc7a9d740ed6b93b\", \"ash_unittests\": \"5e93aeba0228ba5089dc858abdc877524d5f50d4\", \"aura_unittests\": \"a14e78a12fc1aff8aac3a0f66f6f8784bcaa7f5f\", \"base_unittests\": \"90ebae6ce78c435938c06d022d2178ae8e0d4803\", \"base_util_unittests\": \"4caa0c5810051a120a5122e2b0984d39d7be0496\", \"blink_common_unittests\": \"a6b93681f28dd904a163bc0c18d034d0cdfba5ee\", \"blink_fuzzer_unittests\": \"f91260bd13f97cb09c3be89b817592e27585ab0f\", \"blink_heap_unittests\": \"9fbbe76c73e812ebd39163d975909292f8b0b767\", \"blink_platform_unittests\": \"e388c1f30018c5428090e7559a3d0879bd28e578\", \"blink_unittests\": \"56aee096110b7d218220ebdb62ce802b0827da78\", \"boringssl_crypto_tests\": \"536f7ecd7680a7e88b18fcfded2970757ff8b351\", \"boringssl_ssl_tests\": \"1c938d46d3048372a5666fb0e6d95033368fb253\", \"browser_tests\": \"1d181b9268830184fff37041800944af5ffee813\", \"capture_unittests\": \"ee50197486b49746454317338dad4e51418df034\", \"cast_unittests\": \"9a57ad8d2d8b8a1ac6983fdb5c6824e9f7ab6340\", \"cc_unittests\": \"181299b4b3fc262307cba95b82e7553a20b3896b\", \"chrome_app_unittests\": \"dbc7af3d57d1ce22726454fea0da6566418d2989\", \"chromedriver_unittests\": \"380a0cb65a5d9ee88b64889486620853d04854a1\", \"chromeos_components_unittests\": \"92b4833d89ae9a0dcf24d28a581006053db34fc8\", \"chromeos_unittests\": \"d5ec7f0aae84307f41487dc1ac894f59fc9a09a9\", \"components_browsertests\": \"c5b66c7db541e6cc2e5f9cecf4775ba2fc8b555a\", \"components_unittests\": \"4506fa30ec1622f682c510fae3a4794665137f44\", \"compositor_unittests\": \"3c51abcbbe67b99038edb4b7f308d1572beed858\", \"content_browsertests\": \"23cbf645dc48fc6670fd1f5d433ab55dddbba736\", \"content_unittests\": \"16d2ecef26ed2f7fe4baabfa3d4ceb38cd9d444d\", \"crashpad_tests\": \"e8c60606c7db2f3e707aa8b5c0c0bc1ddfd609f1\", \"crypto_unittests\": \"568629ae9649e4c19c808d533c36f8728bb33af5\", \"dbus_unittests\": \"02ad754f823265a76d01ab9384b559da40682aa9\", \"device_unittests\": \"16e8a6827190d6d26b8ca919570547f513e149f0\", \"display_unittests\": \"7b6b6107f727aaa4e670146b038297f94ff0817c\", \"events_unittests\": \"5ca932d51421451a6e531cbd112d1e2eeb940f4b\", \"exo_unittests\": \"173d60f29a8c1dd6a7be675a6781e6d884066044\", \"extensions_browsertests\": \"7225f1b646c160157cc5a5faeb9763f40621c418\", \"extensions_unittests\": \"7a63098cca22acbe008b67ab924887a6189c0ef3\", \"filesystem_service_unittests\": \"aeb101debb48ef541ff609402615f11890eb8c5a\", \"gcm_unit_tests\": \"f88bacb36760d90ea1ff3ab57aafa6b5f026b7dd\", \"gfx_unittests\": \"c4b37c5c13cc2c31a799305469611c8fd053913b\", \"gin_unittests\": \"f4c1baf9a3df99216a932e4272a954079234dd0e\", \"gl_unittests_ozone\": \"6a75fc7fa6c67655769b08e365ad859876906873\", \"google_apis_unittests\": \"67e747966208dcca67c44bccbb884efa46d67ca1\", \"gpu_unittests\": \"0dc59219db3d7b4668b3929095aaa814bdba17ec\", \"gwp_asan_unittests\": \"e465e67d89df2d5f92943521c7a041ff679f6540\", \"interactive_ui_tests\": \"260bbf60f7406d4eace00a42a9d98569a4a3c788\", \"ipc_tests\": \"b2e9ab047e59fdbb828d4ca6b272306eec73477c\", \"jingle_unittests\": \"82c7ed31976be9d183e30b5b909b6769901c0002\", \"keyboard_unittests\": \"43c46d4732970d9290a88bcadfd9bf5dd9c5cb37\", \"latency_unittests\": \"e75f64c59872efd251567ca5086875465d3e19ed\", \"libjingle_xmpp_unittests\": \"6cff0f64c396efc74d386829e23c2a3171bc4b61\", \"liburlpattern_unittests\": \"5d01399f8593740b65e900a4dca5ff387132ac1b\", \"media_blink_unittests\": \"7fb068713ba29aaf3df245f750414c92c618a466\", \"media_unittests\": \"baf7e17d711621c5c0864db6ea51af296682fde4\", \"message_center_unittests\": \"601a6ec8ce4d30aa4410c3804dac391e0b04f104\", \"midi_unittests\": \"cb78ab17237f4fe234594c1a9da464b0c16576ba\", \"mojo_core_unittests\": \"685f576f5c1b458640f4d8c6047b7e23a9a5ee60\", \"mojo_unittests\": \"bcfaec534a8adb4dc83b09172f0c577fd0b5e95f\", \"nacl_helper_nonsfi_unittests\": \"28f479ef93875e507d0771e64001b19474aa365e\", \"nacl_loader_unittests\": \"d87e00ccf48eb35fe7ebb0ebeb390822d8db08f5\", \"native_theme_unittests\": \"503d7cfe3dc02677af29a4ba021f7576e83c707a\", \"net_unittests\": \"0bd540762940745b33c5625c858302f19ce316cd\", \"ozone_gl_unittests\": \"4996dd285931b6730c6870b8b3ddeee8bb5b5bf9\", \"ozone_unittests\": \"026d8da594a0303211a3a4cdcdcbdcfbce034079\", \"ozone_x11_unittests\": \"56b35780d18958a71ef0a20f1541e906a767cb7f\", \"pdf_unittests\": \"68975973579cc0a234242de00cb774abc1aa38bd\", \"perfetto_unittests\": \"74b7f68720a8669e8e765cc4efdffda029232aa7\", \"ppapi_unittests\": \"7cecd163e97f7b750b19bc5019adff388fc05e8f\", \"printing_unittests\": \"64f4e3c7c5c030c4bd4a1b4f05f079fccfd7093b\", \"remoting_unittests\": \"e65ac602b0908d34f746abdd68097b37825ae98f\", \"sandbox_linux_unittests\": \"93e00fca88bd75cad3cee5f3a7f6eb0dad6d9eea\", \"service_manager_unittests\": \"3c33e95018c011bb0350ca93edc38ff08fb2f99e\", \"services_unittests\": \"324b21d17ddd516bcbb205bbd650b36dce499bb1\", \"shell_dialogs_unittests\": \"000bce84f4ae69ae1528992ed7e22a43ba95c920\", \"shell_encryption_unittests\": \"f26769dc9f0f74f6d38f50459ac5bfc8cdd6c3d2\", \"skia_unittests\": \"5b6b43466c029d0bc8a802f69a42a0fb45b6f9ee\", \"snapshot_unittests\": \"1021a6447d958a8ed3d3b1b1bbbb14757103e537\", \"sql_unittests\": \"c1ce64e37d843d3647488d824346734fa0b2d2d2\", \"storage_unittests\": \"32ac198d70aa2a9a8bc1754a095fdb4953bbdb0b\", \"sync_integration_tests\": \"a0a5e76472c7a90d6378b74dc041e83eabc124bc\", \"traffic_annotation_auditor_unittests\": \"40cfa15400bbf039e49330d0e05c28d11af0df10\", \"ui_base_unittests\": \"8f80cb4932858c5ccfa274c6e2a9e41c1c4a6d19\", \"ui_chromeos_unittests\": \"a429c5120fca6411efbdd41d47002d28638209dd\", \"ui_touch_selection_unittests\": \"f654eacf7cd5b0b57be64bee0860a7ef626d3c38\", \"unit_tests\": \"5a5e4418fde3102cb61832f8dba95dc19063631a\", \"url_unittests\": \"b1aa1722368cc09de33a1667f7aac16bc9cb37e6\", \"usage_time_limit_unittests\": \"c98c4e3da4335728b287a2182133ebb5ca743801\", \"views_unittests\": \"93e5d811dbe0ae64cc6d52f1ff3e11cca1afe14c\", \"viz_unittests\": \"38241a6539cc6404e967cde74c308eae3a7bd688\", \"wm_unittests\": \"0ea699951953aab0b1f5889cbda2377e15b1561a\", \"wtf_unittests\": \"e532bd469d62fab7846e0fb37b9bdab9ae560ccc\", \"zlib_unittests\": \"3d451a371b884d64b0f3b7bff5f8e34d4ad80f63\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-89-mvey\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611293971090519",
"status": "COMPLETED",
"status_changed_ts": "1611300446637724",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22297",
"builder:linux-chromeos-dbg",
"buildset:commit/git/ca4d94f4782f12ec25903268188e771863d1dc1e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca4d94f4782f12ec25903268188e771863d1dc1e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022859619494845632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857429557441440752/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:51416bfd42845c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611300446646694",
"url": "https://ci.chromium.org/b/8857429557441440752",
"utcnow_ts": "1611300447692733"
}
}
[07:27:27.715] Invocation finished in 1h48m25.156633637s with status SUCCEEDED