[23:20:54.153] New invocation is queued and will start shortly
[23:20:55.347] Starting the invocation (attempt 1)
[23:20:55.389] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:20:55.390] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:20:55.390] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028500421945634848",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028500421945634848",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"gitiles_ref:refs/heads/master"
]
}
[23:21:01.271] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605914455621992",
"id": "8863070359741400784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605914459657767",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21404",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028500421945634848",
"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/8863070359741400784/+/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": "1605914459657977",
"url": "https://ci.chromium.org/b/8863070359741400784",
"utcnow_ts": "1605914461101059"
}
}
[23:21:01.271] Task URL: https://ci.chromium.org/b/8863070359741400784
[23:21:01.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:2:0) after 1m0s
[23:21:11.173] Received PubSub notification, asking Buildbucket for the build status
[23:21:11.250] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:01.302] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:2:0)
[23:22:01.302] Timer tick, asking Buildbucket for the build status
[23:22:02.077] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:02.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:4:0) after 1m0s
[23:23:02.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:4:0)
[23:23:02.146] Timer tick, asking Buildbucket for the build status
[23:23:02.242] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:02.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:5:0) after 1m0s
[23:24:02.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:5:0)
[23:24:02.513] Timer tick, asking Buildbucket for the build status
[23:24:02.584] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:02.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:6:0) after 1m0s
[23:25:02.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:6:0)
[23:25:02.792] Timer tick, asking Buildbucket for the build status
[23:25:02.891] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:02.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:7:0) after 1m0s
[23:26:02.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:7:0)
[23:26:02.975] Timer tick, asking Buildbucket for the build status
[23:26:03.087] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:03.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:8:0) after 1m0s
[23:27:03.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:8:0)
[23:27:03.143] Timer tick, asking Buildbucket for the build status
[23:27:03.449] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:03.449] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:9:0) after 1m0s
[23:28:04.873] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:9:0)
[23:28:04.873] Timer tick, asking Buildbucket for the build status
[23:28:06.863] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:06.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:10:0) after 1m0s
[23:29:06.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:10:0)
[23:29:06.949] Timer tick, asking Buildbucket for the build status
[23:29:07.374] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:07.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:11:0) after 1m0s
[23:30:08.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:11:0)
[23:30:08.090] Timer tick, asking Buildbucket for the build status
[23:30:08.170] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:08.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:12:0) after 1m0s
[23:31:08.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:12:0)
[23:31:08.357] Timer tick, asking Buildbucket for the build status
[23:31:08.565] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:08.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:13:0) after 1m0s
[23:32:08.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:13:0)
[23:32:08.618] Timer tick, asking Buildbucket for the build status
[23:32:08.690] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:08.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:14:0) after 1m0s
[23:33:08.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:14:0)
[23:33:08.799] Timer tick, asking Buildbucket for the build status
[23:33:08.967] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:08.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:15:0) after 1m0s
[23:34:08.988] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:15:0)
[23:34:08.988] Timer tick, asking Buildbucket for the build status
[23:34:09.586] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:09.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:16:0) after 1m0s
[23:35:09.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:16:0)
[23:35:09.609] Timer tick, asking Buildbucket for the build status
[23:35:09.694] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:09.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:17:0) after 1m0s
[23:36:09.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:17:0)
[23:36:09.765] Timer tick, asking Buildbucket for the build status
[23:36:09.888] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:09.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:18:0) after 1m0s
[23:37:09.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:18:0)
[23:37:09.965] Timer tick, asking Buildbucket for the build status
[23:37:10.028] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:10.028] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:19:0) after 1m0s
[23:38:10.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:19:0)
[23:38:10.111] Timer tick, asking Buildbucket for the build status
[23:38:10.183] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:10.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:20:0) after 1m0s
[23:39:10.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:20:0)
[23:39:10.222] Timer tick, asking Buildbucket for the build status
[23:39:10.282] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:10.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:21:0) after 1m0s
[23:40:10.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:21:0)
[23:40:10.338] Timer tick, asking Buildbucket for the build status
[23:40:13.901] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:13.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:22:0) after 1m0s
[23:41:13.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:22:0)
[23:41:13.947] Timer tick, asking Buildbucket for the build status
[23:41:14.048] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:14.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:23:0) after 1m0s
[23:42:14.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:23:0)
[23:42:14.177] Timer tick, asking Buildbucket for the build status
[23:42:14.237] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:14.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:24:0) after 1m0s
[23:43:14.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:24:0)
[23:43:14.295] Timer tick, asking Buildbucket for the build status
[23:43:14.415] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:14.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:25:0) after 1m0s
[23:44:14.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:25:0)
[23:44:14.510] Timer tick, asking Buildbucket for the build status
[23:44:14.820] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:14.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:26:0) after 1m0s
[23:45:14.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:26:0)
[23:45:14.849] Timer tick, asking Buildbucket for the build status
[23:45:15.132] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:15.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:27:0) after 1m0s
[23:46:15.166] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:27:0)
[23:46:15.166] Timer tick, asking Buildbucket for the build status
[23:46:15.418] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:15.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:28:0) after 1m0s
[23:47:15.451] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:28:0)
[23:47:15.451] Timer tick, asking Buildbucket for the build status
[23:47:15.536] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:15.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:29:0) after 1m0s
[23:48:15.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:29:0)
[23:48:15.593] Timer tick, asking Buildbucket for the build status
[23:48:15.742] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:15.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:30:0) after 1m0s
[23:49:15.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:30:0)
[23:49:15.730] Timer tick, asking Buildbucket for the build status
[23:49:15.794] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:15.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:31:0) after 1m0s
[23:50:15.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:31:0)
[23:50:15.856] Timer tick, asking Buildbucket for the build status
[23:50:16.239] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:16.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:32:0) after 1m0s
[23:51:16.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:32:0)
[23:51:16.239] Timer tick, asking Buildbucket for the build status
[23:51:16.368] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:16.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:33:0) after 1m0s
[23:52:16.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:33:0)
[23:52:16.424] Timer tick, asking Buildbucket for the build status
[23:52:16.581] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:16.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:34:0) after 1m0s
[23:53:16.628] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:34:0)
[23:53:16.628] Timer tick, asking Buildbucket for the build status
[23:53:16.909] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:16.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:35:0) after 1m0s
[23:54:16.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:35:0)
[23:54:16.966] Timer tick, asking Buildbucket for the build status
[23:54:17.033] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:17.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:36:0) after 1m0s
[23:55:17.073] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:36:0)
[23:55:17.073] Timer tick, asking Buildbucket for the build status
[23:55:17.158] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:17.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:37:0) after 1m0s
[23:56:17.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:37:0)
[23:56:17.189] Timer tick, asking Buildbucket for the build status
[23:56:17.294] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:17.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:38:0) after 1m0s
[23:57:17.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:38:0)
[23:57:17.427] Timer tick, asking Buildbucket for the build status
[23:57:17.656] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:17.656] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:39:0) after 1m0s
[23:58:17.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:39:0)
[23:58:17.730] Timer tick, asking Buildbucket for the build status
[23:58:17.951] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:17.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:40:0) after 1m0s
[23:59:18.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:40:0)
[23:59:18.017] Timer tick, asking Buildbucket for the build status
[23:59:18.790] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:18.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:41:0) after 1m0s
[00:00:18.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:41:0)
[00:00:18.824] Timer tick, asking Buildbucket for the build status
[00:00:20.104] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:20.104] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:42:0) after 1m0s
[00:01:20.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:42:0)
[00:01:20.168] Timer tick, asking Buildbucket for the build status
[00:01:20.415] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:20.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:43:0) after 1m0s
[00:02:20.523] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:43:0)
[00:02:20.523] Timer tick, asking Buildbucket for the build status
[00:02:20.685] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:20.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:44:0) after 1m0s
[00:03:20.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:44:0)
[00:03:20.741] Timer tick, asking Buildbucket for the build status
[00:03:21.143] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:21.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:45:0) after 1m0s
[00:04:21.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:45:0)
[00:04:21.180] Timer tick, asking Buildbucket for the build status
[00:04:21.252] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:21.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:46:0) after 1m0s
[00:05:21.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:46:0)
[00:05:21.288] Timer tick, asking Buildbucket for the build status
[00:05:21.366] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:21.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:47:0) after 1m0s
[00:06:21.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:47:0)
[00:06:21.437] Timer tick, asking Buildbucket for the build status
[00:06:21.571] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:21.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:48:0) after 1m0s
[00:07:21.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:48:0)
[00:07:21.593] Timer tick, asking Buildbucket for the build status
[00:07:21.771] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:21.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:49:0) after 1m0s
[00:08:21.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:49:0)
[00:08:21.821] Timer tick, asking Buildbucket for the build status
[00:08:21.927] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:21.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:50:0) after 1m0s
[00:09:21.914] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:50:0)
[00:09:21.914] Timer tick, asking Buildbucket for the build status
[00:09:21.989] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:21.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:51:0) after 1m0s
[00:10:22.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:51:0)
[00:10:22.029] Timer tick, asking Buildbucket for the build status
[00:10:22.167] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:22.167] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:52:0) after 1m0s
[00:11:22.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:52:0)
[00:11:22.243] Timer tick, asking Buildbucket for the build status
[00:11:22.364] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:22.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:53:0) after 1m0s
[00:12:22.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:53:0)
[00:12:22.427] Timer tick, asking Buildbucket for the build status
[00:12:22.638] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:22.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:54:0) after 1m0s
[00:13:22.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:54:0)
[00:13:22.667] Timer tick, asking Buildbucket for the build status
[00:13:22.750] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:55:0) after 1m0s
[00:14:22.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:55:0)
[00:14:22.769] Timer tick, asking Buildbucket for the build status
[00:14:23.109] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:23.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:56:0) after 1m0s
[00:15:23.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:56:0)
[00:15:23.130] Timer tick, asking Buildbucket for the build status
[00:15:23.193] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:23.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:57:0) after 1m0s
[00:16:23.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:57:0)
[00:16:23.277] Timer tick, asking Buildbucket for the build status
[00:16:23.403] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:23.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:58:0) after 1m0s
[00:17:23.423] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:58:0)
[00:17:23.423] Timer tick, asking Buildbucket for the build status
[00:17:23.527] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:23.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:59:0) after 1m0s
[00:18:23.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:59:0)
[00:18:23.589] Timer tick, asking Buildbucket for the build status
[00:18:24.144] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:24.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:60:0) after 1m0s
[00:19:24.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:60:0)
[00:19:24.216] Timer tick, asking Buildbucket for the build status
[00:19:24.635] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:24.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:61:0) after 1m0s
[00:20:24.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:61:0)
[00:20:24.643] Timer tick, asking Buildbucket for the build status
[00:20:25.664] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:25.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:62:0) after 1m0s
[00:21:25.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:62:0)
[00:21:25.769] Timer tick, asking Buildbucket for the build status
[00:21:28.693] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:28.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:63:0) after 1m0s
[00:22:28.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:63:0)
[00:22:28.706] Timer tick, asking Buildbucket for the build status
[00:22:28.875] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:28.875] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:64:0) after 1m0s
[00:23:28.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:64:0)
[00:23:28.884] Timer tick, asking Buildbucket for the build status
[00:23:29.601] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:29.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:65:0) after 1m0s
[00:24:29.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:65:0)
[00:24:29.601] Timer tick, asking Buildbucket for the build status
[00:24:29.786] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:29.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:66:0) after 1m0s
[00:25:29.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:66:0)
[00:25:29.864] Timer tick, asking Buildbucket for the build status
[00:25:29.970] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:29.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:67:0) after 1m0s
[00:26:29.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:67:0)
[00:26:29.983] Timer tick, asking Buildbucket for the build status
[00:26:30.112] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:30.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:68:0) after 1m0s
[00:27:30.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:68:0)
[00:27:30.156] Timer tick, asking Buildbucket for the build status
[00:27:30.261] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:69:0) after 1m0s
[00:28:30.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:69:0)
[00:28:30.278] Timer tick, asking Buildbucket for the build status
[00:28:30.357] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:70:0) after 1m0s
[00:29:30.511] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:70:0)
[00:29:30.511] Timer tick, asking Buildbucket for the build status
[00:29:30.600] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:30.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:71:0) after 1m0s
[00:30:30.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:71:0)
[00:30:30.663] Timer tick, asking Buildbucket for the build status
[00:30:30.780] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:30.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:72:0) after 1m0s
[00:31:30.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:72:0)
[00:31:30.875] Timer tick, asking Buildbucket for the build status
[00:31:31.003] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:31.003] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:73:0) after 1m0s
[00:32:31.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:73:0)
[00:32:31.093] Timer tick, asking Buildbucket for the build status
[00:32:31.175] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:31.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:74:0) after 1m0s
[00:33:31.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:74:0)
[00:33:31.176] Timer tick, asking Buildbucket for the build status
[00:33:31.287] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:31.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:75:0) after 1m0s
[00:34:31.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:75:0)
[00:34:31.367] Timer tick, asking Buildbucket for the build status
[00:34:31.478] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:31.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:76:0) after 1m0s
[00:35:31.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:76:0)
[00:35:31.531] Timer tick, asking Buildbucket for the build status
[00:35:31.637] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:31.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:77:0) after 1m0s
[00:36:31.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:77:0)
[00:36:31.667] Timer tick, asking Buildbucket for the build status
[00:36:31.795] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:31.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:78:0) after 1m0s
[00:37:31.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:78:0)
[00:37:31.860] Timer tick, asking Buildbucket for the build status
[00:37:31.983] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:31.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:79:0) after 1m0s
[00:38:31.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:79:0)
[00:38:31.999] Timer tick, asking Buildbucket for the build status
[00:38:32.069] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:32.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:80:0) after 1m0s
[00:39:32.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:80:0)
[00:39:32.123] Timer tick, asking Buildbucket for the build status
[00:39:32.241] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:32.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:81:0) after 1m0s
[00:40:32.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:81:0)
[00:40:32.360] Timer tick, asking Buildbucket for the build status
[00:40:34.205] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:34.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:82:0) after 1m0s
[00:41:34.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:82:0)
[00:41:34.360] Timer tick, asking Buildbucket for the build status
[00:41:34.464] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:34.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:83:0) after 1m0s
[00:42:34.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:83:0)
[00:42:34.567] Timer tick, asking Buildbucket for the build status
[00:42:34.721] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:34.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:84:0) after 1m0s
[00:43:34.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:84:0)
[00:43:34.743] Timer tick, asking Buildbucket for the build status
[00:43:34.837] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:34.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:85:0) after 1m0s
[00:44:34.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:85:0)
[00:44:34.863] Timer tick, asking Buildbucket for the build status
[00:44:34.964] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:34.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:86:0) after 1m0s
[00:45:35.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:86:0)
[00:45:35.049] Timer tick, asking Buildbucket for the build status
[00:45:35.124] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:35.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:87:0) after 1m0s
[00:46:35.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:87:0)
[00:46:35.241] Timer tick, asking Buildbucket for the build status
[00:46:35.360] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:35.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:88:0) after 1m0s
[00:47:35.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:88:0)
[00:47:35.391] Timer tick, asking Buildbucket for the build status
[00:47:35.655] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:35.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:89:0) after 1m0s
[00:48:35.749] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:89:0)
[00:48:35.749] Timer tick, asking Buildbucket for the build status
[00:48:35.818] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:35.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:90:0) after 1m0s
[00:49:35.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:90:0)
[00:49:35.948] Timer tick, asking Buildbucket for the build status
[00:49:36.197] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:36.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:91:0) after 1m0s
[00:50:36.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:91:0)
[00:50:36.317] Timer tick, asking Buildbucket for the build status
[00:50:36.471] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:36.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:92:0) after 1m0s
[00:51:36.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:92:0)
[00:51:36.515] Timer tick, asking Buildbucket for the build status
[00:51:36.635] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:36.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:93:0) after 1m0s
[00:52:36.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:93:0)
[00:52:36.707] Timer tick, asking Buildbucket for the build status
[00:52:36.791] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:36.791] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:94:0) after 1m0s
[00:53:36.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:94:0)
[00:53:36.796] Timer tick, asking Buildbucket for the build status
[00:53:36.946] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:36.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:95:0) after 1m0s
[00:54:36.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:95:0)
[00:54:36.955] Timer tick, asking Buildbucket for the build status
[00:54:37.696] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:37.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:96:0) after 1m0s
[00:55:37.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:96:0)
[00:55:37.815] Timer tick, asking Buildbucket for the build status
[00:55:38.116] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:38.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:97:0) after 1m0s
[00:56:38.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:97:0)
[00:56:38.186] Timer tick, asking Buildbucket for the build status
[00:56:38.295] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:38.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:98:0) after 1m0s
[00:57:38.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:98:0)
[00:57:38.348] Timer tick, asking Buildbucket for the build status
[00:57:38.428] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:38.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:99:0) after 1m0s
[00:58:38.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:99:0)
[00:58:38.488] Timer tick, asking Buildbucket for the build status
[00:58:38.692] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:38.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:100:0) after 1m0s
[00:59:38.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:100:0)
[00:59:38.766] Timer tick, asking Buildbucket for the build status
[00:59:38.842] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:38.842] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:101:0) after 1m0s
[01:00:38.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:101:0)
[01:00:38.918] Timer tick, asking Buildbucket for the build status
[01:00:39.082] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:39.082] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:102:0) after 1m0s
[01:01:39.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:102:0)
[01:01:39.180] Timer tick, asking Buildbucket for the build status
[01:01:39.386] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:39.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:103:0) after 1m0s
[01:02:39.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:103:0)
[01:02:39.553] Timer tick, asking Buildbucket for the build status
[01:02:39.871] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:39.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:104:0) after 1m0s
[01:03:39.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:104:0)
[01:03:39.950] Timer tick, asking Buildbucket for the build status
[01:03:40.611] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:40.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:105:0) after 1m0s
[01:04:40.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:105:0)
[01:04:40.596] Timer tick, asking Buildbucket for the build status
[01:04:40.810] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:40.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:106:0) after 1m0s
[01:05:41.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:106:0)
[01:05:41.004] Timer tick, asking Buildbucket for the build status
[01:05:41.158] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:41.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:107:0) after 1m0s
[01:06:41.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:107:0)
[01:06:41.218] Timer tick, asking Buildbucket for the build status
[01:06:41.872] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:41.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:108:0) after 1m0s
[01:07:41.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:108:0)
[01:07:41.953] Timer tick, asking Buildbucket for the build status
[01:07:42.068] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:42.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:109:0) after 1m0s
[01:08:42.114] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:109:0)
[01:08:42.114] Timer tick, asking Buildbucket for the build status
[01:08:42.200] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:42.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:110:0) after 1m0s
[01:09:42.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:110:0)
[01:09:42.255] Timer tick, asking Buildbucket for the build status
[01:09:42.555] Build 8863070359741400784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:42.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028500421945634848:111:0) after 1m0s
[01:09:50.843] Received PubSub notification, asking Buildbucket for the build status
[01:09:50.960] Build 8863070359741400784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:09:50.960] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605920989169669",
"created_by": "project:chromium",
"created_ts": "1605914455621992",
"id": "8863070359741400784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\"}}",
"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\": \"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\", \"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-179-dr25\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21404, \"got_angle_revision\": \"c4ca12e32e6aef9f5f8eb06c4b361264bec19f8d\", \"got_dawn_revision\": \"41b3f9c1e4aaaa3d56d205d81e61deaebdd40d75\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\", \"got_revision_cp\": \"refs/heads/master@{#829851}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"aeb3616301c8a2988ede07e4c34e8975da4d5fa0\", \"got_v8_revision\": \"8a682e08571d84f1d93ef73a07cfac7a089676c9\", \"got_v8_revision_cp\": \"refs/heads/8.9.28@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b\", \"swarm_hashes_refs/heads/master(at){#829851}_without_patch\": {\"absl_hardening_tests\": \"61c615bf1ee0fd383f5e3fc0630b69fa71fc4744\", \"accessibility_unittests\": \"a85d6ced9cc2c24abb1531c8574c8a7b79378b5e\", \"angle_unittests\": \"43c06e5a1a7eda15089ae57199a9ddbcb468b956\", \"app_list_unittests\": \"8edcf5ff4edb463df299e77f6d002ad558c1e5fc\", \"app_shell_unittests\": \"e6908cdcc2dc862dd6083497cfeec6b6241bb683\", \"ash_unittests\": \"4bba343f1e2e0e9c0f4dfbe07af2668aed4010ac\", \"aura_unittests\": \"c8790dc3d75be0333a0e9fc14e8ab0409ad2816a\", \"base_unittests\": \"85cb83912942ebf80173882a0c6012664c54de12\", \"base_util_unittests\": \"1004463d1eeb722ad017e32facfcb470cebf306c\", \"blink_common_unittests\": \"9463d1ddd9ae23262aade0abc2fb31b4269e0570\", \"blink_fuzzer_unittests\": \"52ede3d275530db77dffb9e26c56df697ea00d8a\", \"blink_heap_unittests\": \"0ee84db13d13210c62b6bf508f57d7139959ce36\", \"blink_platform_unittests\": \"3b2568606a26736c7551c0a0a240ebff92d1c780\", \"blink_unittests\": \"f3d651c4d36da68e90affb8b27489e4932493ea3\", \"boringssl_crypto_tests\": \"4a2e1dfb5f3b5921019712baf9bba618e0f70ed8\", \"boringssl_ssl_tests\": \"2599dfe99875a1524fa0326ffcb1d8309b6deffb\", \"browser_tests\": \"3d5124cbe7997b704101e2498476dd5b241c6910\", \"capture_unittests\": \"aefe9e66d8c318881505201fe61aaf2a87461bb6\", \"cast_unittests\": \"99f932af8e92e4c140ff6d3344b47c25aee21b6e\", \"cc_unittests\": \"eebd5da193064edf9f6ba607895c894a2cb76b3b\", \"chrome_app_unittests\": \"8c906e63e9001a5e3ef1eb380d0f4a2426ec5c40\", \"chromedriver_unittests\": \"3eadd8f7beef8ee89bdcc78fa2aea5d1db3f6c94\", \"chromeos_components_unittests\": \"e9364f7df258277ef210add48eea994171505cfb\", \"chromeos_unittests\": \"8611605fd086aa782b371bbfb3afb00efbddba67\", \"components_browsertests\": \"60b10ff98636ed4651336e31964f750002c3d64a\", \"components_unittests\": \"c5c5c757a772d98d5af07b474a9b1679d3d26529\", \"compositor_unittests\": \"86f92c253aa8e39e218d395efbd7246f7f54ca1b\", \"content_browsertests\": \"ddd85632e442cbad81f38165e1c53f3dc3391b4e\", \"content_unittests\": \"72fe5179981f60575ed7aeb5ecab5dc31a99d813\", \"crashpad_tests\": \"a171a3f5c45cff7bcf6b2c98606014fabbffdf47\", \"crypto_unittests\": \"60311581d6c540cc7e349920575ff3ad3b5d6554\", \"dbus_unittests\": \"a130f9644c9d0f7c2540298a07ddd5be9fb3bab9\", \"device_unittests\": \"59ed1cda401e9ffbca0453564558e5f076efcb00\", \"display_unittests\": \"757315ddf1f0cac7d673af697f2db41d85938bda\", \"events_unittests\": \"98330226b2d1d6846d845a465190f65010a4686d\", \"exo_unittests\": \"7d9658621f5c25b919a53df1f41a363ba7f67469\", \"extensions_browsertests\": \"e3f5bca4b5359c0b8635296b563b3a32766c8347\", \"extensions_unittests\": \"08fb66582baa1fd24f60d7b7f6baf9191b574428\", \"filesystem_service_unittests\": \"6d793acedbe4c6fbdc47456577eceb41fbc669b5\", \"gcm_unit_tests\": \"b08bc2dd1269fa1c9c6dbe486f4cc9aac59466f5\", \"gfx_unittests\": \"0889925b83d0a057220602df39d2606e82535aaf\", \"gin_unittests\": \"1dfef596267de5cc2bb7f4601c0bf99f4e9f1488\", \"gl_unittests_ozone\": \"b9ebb5355dff5db5ba2eb121f90032d37fa33265\", \"google_apis_unittests\": \"dd0d0243d4b4d865b445978341a840dd52bd1bbf\", \"gpu_unittests\": \"2d62491fb2656bd38386cff8e18a7cc10c2ee241\", \"gwp_asan_unittests\": \"17bf5857d03f1d441767a9c49079d0f16b96be5a\", \"interactive_ui_tests\": \"3f9233b2014dd9b9c9781d1a2cf6f9ae53a5e04e\", \"ipc_tests\": \"6ac1b5a46d766016414723062926c864d9c27a0e\", \"jingle_unittests\": \"4cc899e918e430780573a4b5c7fb20fba6757205\", \"keyboard_unittests\": \"e3e506778a3b26915401fad088835b53260043c2\", \"latency_unittests\": \"144280e7748d1f605060d29910fc1a12b39c991d\", \"libjingle_xmpp_unittests\": \"d0f907632152a594f34178e987e81da0fc4308e8\", \"liburlpattern_unittests\": \"21e67dd1697eb245ba3dc7c761ec099f881ac921\", \"media_blink_unittests\": \"712a35ca3141cbaef253c2d162430e10c4e6dc70\", \"media_unittests\": \"00e16330d5e7e236c5cf28d6be5c291f2c74c715\", \"message_center_unittests\": \"ce70b109b7b559b77414a34766b7fadb57c7d2b0\", \"midi_unittests\": \"b5972fe09f873b0256914560e46618bd77945054\", \"mojo_core_unittests\": \"61a146ffb5f969ae8049049b840bb8b00c2d0c27\", \"mojo_unittests\": \"a47549ef5bf7100fa23f5281c11fe6ab82e4204b\", \"nacl_helper_nonsfi_unittests\": \"b3f1810c361f74c3acf45659b18160b6c99ebb5a\", \"nacl_loader_unittests\": \"d3da96d2de9e4124f99ff3085d212f0c1a940e0e\", \"native_theme_unittests\": \"9205926521fd13ae74a8d1802eb6d386fd6cbb00\", \"net_unittests\": \"4c7ed060d60353bf11cfaeadbb45e9792f6f46aa\", \"ozone_gl_unittests\": \"cf1a08e12d3cac23ad0bb9ebc5e0c89183d076b2\", \"ozone_unittests\": \"4e5b0bc03918175dbd7f9d3463fa9e452039825f\", \"ozone_x11_unittests\": \"c6af27f1e6f2cb36107400f1d6409d0fedaf0ea0\", \"pdf_unittests\": \"bb11a9d6ae716c5ea693468b0002ae7214808f5d\", \"perfetto_unittests\": \"0bf9c3fd7221669a75586b223907450448eaadb9\", \"ppapi_unittests\": \"6de241688741f38d249ddb6389a91bda6ced7f43\", \"printing_unittests\": \"6dd39e7c008fa9dd19fa1e46ac9cbd2c47c5d76d\", \"remoting_unittests\": \"ed744f11734108319edcd154128a19180390c130\", \"sandbox_linux_unittests\": \"491848cffff9a72ff710ae0def58cebadc0f6768\", \"service_manager_unittests\": \"7b3c3d49e00c0fce27b56cb4e1a2f626c488814f\", \"services_unittests\": \"613a7a7d5b32e2899f242ea644742a0660328b80\", \"shell_dialogs_unittests\": \"ab3bfc1290cc80089d7f677cd257812abcc029c3\", \"skia_unittests\": \"3a36adc7b223d54e38d6efe8a542d5d5c802a371\", \"snapshot_unittests\": \"ff79d32a7982be469eac8e1b72a5bfa6b22b0259\", \"sql_unittests\": \"dc5a4bd67bf07cb45afb2e99fa6882b0a2d5e078\", \"storage_unittests\": \"08d1e9f49b2cddbd5cbd166241a92acd19fa885a\", \"sync_integration_tests\": \"52cb332231a0e165f3cb39ff13de419d38249157\", \"traffic_annotation_auditor_unittests\": \"a1cd0d3805d2c9ed061d33a0a23ee77fa3ba8415\", \"ui_base_unittests\": \"52074c0cdc8f2e61242610b54624bb11cb300f3e\", \"ui_chromeos_unittests\": \"83b5eca85486b53008742eab31416425e1d0418f\", \"ui_touch_selection_unittests\": \"d650cabcc58b0c46bc04f630788f83d30f926b1d\", \"unit_tests\": \"4505209e0c30d115a6929c7be9a557b3af9995b5\", \"url_unittests\": \"5a1fb83bda06ec80e947cca81ab97adda2d5f5d8\", \"usage_time_limit_unittests\": \"7d2f8e5b3f04849163ee6f46e09fdbe90a778177\", \"views_unittests\": \"fa636bac8ca0977b55a43a669ab67af307cc8d43\", \"viz_unittests\": \"774f62e73fbe926bed0f09d62854f95a46ae2da0\", \"wm_unittests\": \"e7ad5ba6ab08d29da1c598c926d25d5c97d3651f\", \"wtf_unittests\": \"978f6543176ef8dd27cab9464f689a3a97a5891d\", \"zlib_unittests\": \"5acdae27abeaf43b9b1f073a7141ae4692dad1bc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_bea46eaeedb7de1bd52f00a0308b818fe481ae542888a2fa5825ab1ef5ba3493_v2\", \"builder_dd987fcd94b516d81fcf1552cd73a9eed370c3dc02cc1a52ddee828f1ab8817d_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-179-dr25\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605914467124110",
"status": "COMPLETED",
"status_changed_ts": "1605920989831667",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21404",
"builder:linux-chromeos-dbg",
"buildset:commit/git/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6b5cfa805e94f3b1aa90dbf848de23adf7e3c22b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028500421945634848",
"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/8863070359741400784/+/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:5000c7895213f410",
"user_agent:luci-scheduler"
],
"updated_ts": "1605920989858386",
"url": "https://ci.chromium.org/b/8863070359741400784",
"utcnow_ts": "1605920990949607"
}
}
[01:09:50.960] Invocation finished in 1h48m56.824731836s with status SUCCEEDED