[22:41:42.627] New invocation is queued and will start shortly
[22:41:43.765] Starting the invocation (attempt 1)
[22:41:43.797] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:41:43.797] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:41:43.797] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019986772855012624",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019986772855012624",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"gitiles_ref:refs/heads/master"
]
}
[22:41:44.771] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614033703937158",
"id": "8854556710819160464",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614033704509073",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22735",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019986772855012624",
"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/8854556710819160464/+/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": "1614033704509255",
"url": "https://ci.chromium.org/b/8854556710819160464",
"utcnow_ts": "1614033704763647"
}
}
[22:41:44.771] Task URL: https://ci.chromium.org/b/8854556710819160464
[22:41:44.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:2:0) after 1m0s
[22:42:15.941] Received PubSub notification, asking Buildbucket for the build status
[22:42:16.006] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:44.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:2:0)
[22:42:44.953] Timer tick, asking Buildbucket for the build status
[22:42:45.165] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:45.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:4:0) after 1m0s
[22:43:45.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:4:0)
[22:43:45.304] Timer tick, asking Buildbucket for the build status
[22:43:45.549] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:45.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:5:0) after 1m0s
[22:44:45.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:5:0)
[22:44:45.662] Timer tick, asking Buildbucket for the build status
[22:44:45.937] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:45.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:6:0) after 1m0s
[22:45:45.997] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:6:0)
[22:45:45.997] Timer tick, asking Buildbucket for the build status
[22:45:46.111] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:46.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:7:0) after 1m0s
[22:46:46.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:7:0)
[22:46:46.209] Timer tick, asking Buildbucket for the build status
[22:46:46.303] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:46.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:8:0) after 1m0s
[22:47:46.367] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:8:0)
[22:47:46.367] Timer tick, asking Buildbucket for the build status
[22:47:46.833] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:46.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:9:0) after 1m0s
[22:48:46.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:9:0)
[22:48:46.925] Timer tick, asking Buildbucket for the build status
[22:48:48.171] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:48.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:10:0) after 1m0s
[22:49:48.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:10:0)
[22:49:48.349] Timer tick, asking Buildbucket for the build status
[22:49:48.422] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:48.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:11:0) after 1m0s
[22:50:48.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:11:0)
[22:50:48.528] Timer tick, asking Buildbucket for the build status
[22:50:48.607] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:48.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:12:0) after 1m0s
[22:51:48.652] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:12:0)
[22:51:48.652] Timer tick, asking Buildbucket for the build status
[22:51:49.041] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:49.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:13:0) after 1m0s
[22:52:49.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:13:0)
[22:52:49.092] Timer tick, asking Buildbucket for the build status
[22:52:49.263] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:49.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:14:0) after 1m0s
[22:53:49.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:14:0)
[22:53:49.439] Timer tick, asking Buildbucket for the build status
[22:53:49.722] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:49.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:15:0) after 1m0s
[22:54:49.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:15:0)
[22:54:49.767] Timer tick, asking Buildbucket for the build status
[22:54:50.031] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:50.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:16:0) after 1m0s
[22:55:50.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:16:0)
[22:55:50.053] Timer tick, asking Buildbucket for the build status
[22:55:50.137] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:50.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:17:0) after 1m0s
[22:56:50.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:17:0)
[22:56:50.256] Timer tick, asking Buildbucket for the build status
[22:56:50.493] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:50.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:18:0) after 1m0s
[22:57:50.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:18:0)
[22:57:50.544] Timer tick, asking Buildbucket for the build status
[22:57:50.760] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:50.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:19:0) after 1m0s
[22:58:50.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:19:0)
[22:58:50.842] Timer tick, asking Buildbucket for the build status
[22:58:51.107] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:51.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:20:0) after 1m0s
[22:59:54.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:20:0)
[22:59:54.600] Timer tick, asking Buildbucket for the build status
[22:59:54.833] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:54.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:21:0) after 1m0s
[23:00:54.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:21:0)
[23:00:54.802] Timer tick, asking Buildbucket for the build status
[23:00:54.884] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:54.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:22:0) after 1m0s
[23:01:54.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:22:0)
[23:01:54.905] Timer tick, asking Buildbucket for the build status
[23:01:54.990] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:23:0) after 1m0s
[23:02:55.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:23:0)
[23:02:55.037] Timer tick, asking Buildbucket for the build status
[23:02:55.126] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:55.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:24:0) after 1m0s
[23:03:55.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:24:0)
[23:03:55.157] Timer tick, asking Buildbucket for the build status
[23:03:55.256] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:55.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:25:0) after 1m0s
[23:04:55.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:25:0)
[23:04:55.274] Timer tick, asking Buildbucket for the build status
[23:04:55.345] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:55.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:26:0) after 1m0s
[23:05:55.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:26:0)
[23:05:55.596] Timer tick, asking Buildbucket for the build status
[23:05:55.952] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:55.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:27:0) after 1m0s
[23:06:56.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:27:0)
[23:06:56.374] Timer tick, asking Buildbucket for the build status
[23:06:56.633] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:56.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:28:0) after 1m0s
[23:07:56.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:28:0)
[23:07:56.738] Timer tick, asking Buildbucket for the build status
[23:07:57.017] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:57.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:29:0) after 1m0s
[23:08:57.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:29:0)
[23:08:57.151] Timer tick, asking Buildbucket for the build status
[23:08:57.336] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:57.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:30:0) after 1m0s
[23:09:57.353] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:30:0)
[23:09:57.353] Timer tick, asking Buildbucket for the build status
[23:09:57.803] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:57.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:31:0) after 1m0s
[23:10:57.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:31:0)
[23:10:57.909] Timer tick, asking Buildbucket for the build status
[23:10:57.989] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:57.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:32:0) after 1m0s
[23:11:58.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:32:0)
[23:11:58.051] Timer tick, asking Buildbucket for the build status
[23:11:58.222] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:58.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:33:0) after 1m0s
[23:12:58.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:33:0)
[23:12:58.312] Timer tick, asking Buildbucket for the build status
[23:12:58.389] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:58.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:34:0) after 1m0s
[23:13:58.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:34:0)
[23:13:58.533] Timer tick, asking Buildbucket for the build status
[23:13:58.753] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:58.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:35:0) after 1m0s
[23:14:58.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:35:0)
[23:14:58.841] Timer tick, asking Buildbucket for the build status
[23:14:58.929] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:58.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:36:0) after 1m0s
[23:15:59.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:36:0)
[23:15:59.004] Timer tick, asking Buildbucket for the build status
[23:15:59.197] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:37:0) after 1m0s
[23:16:59.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:37:0)
[23:16:59.194] Timer tick, asking Buildbucket for the build status
[23:16:59.529] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:59.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:38:0) after 1m0s
[23:17:59.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:38:0)
[23:17:59.585] Timer tick, asking Buildbucket for the build status
[23:17:59.826] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:59.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:39:0) after 1m0s
[23:18:59.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:39:0)
[23:18:59.835] Timer tick, asking Buildbucket for the build status
[23:18:59.922] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:59.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:40:0) after 1m0s
[23:20:00.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:40:0)
[23:20:00.098] Timer tick, asking Buildbucket for the build status
[23:20:00.304] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:00.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:41:0) after 1m0s
[23:21:01.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:41:0)
[23:21:01.012] Timer tick, asking Buildbucket for the build status
[23:21:01.162] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:01.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:42:0) after 1m0s
[23:22:01.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:42:0)
[23:22:01.159] Timer tick, asking Buildbucket for the build status
[23:22:01.421] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:01.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:43:0) after 1m0s
[23:23:01.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:43:0)
[23:23:01.767] Timer tick, asking Buildbucket for the build status
[23:23:01.849] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:01.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:44:0) after 1m0s
[23:24:01.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:44:0)
[23:24:01.830] Timer tick, asking Buildbucket for the build status
[23:24:01.908] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:01.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:45:0) after 1m0s
[23:25:01.969] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:45:0)
[23:25:01.969] Timer tick, asking Buildbucket for the build status
[23:25:02.046] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:02.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:46:0) after 1m0s
[23:26:02.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:46:0)
[23:26:02.050] Timer tick, asking Buildbucket for the build status
[23:26:02.217] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:02.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:47:0) after 1m0s
[23:27:02.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:47:0)
[23:27:02.240] Timer tick, asking Buildbucket for the build status
[23:27:02.913] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:02.913] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:48:0) after 1m0s
[23:28:02.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:48:0)
[23:28:02.953] Timer tick, asking Buildbucket for the build status
[23:28:03.039] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:03.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:49:0) after 1m0s
[23:29:03.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:49:0)
[23:29:03.465] Timer tick, asking Buildbucket for the build status
[23:29:04.095] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:04.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:50:0) after 1m0s
[23:30:04.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:50:0)
[23:30:04.763] Timer tick, asking Buildbucket for the build status
[23:30:05.098] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:05.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:51:0) after 1m0s
[23:31:05.704] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:51:0)
[23:31:05.704] Timer tick, asking Buildbucket for the build status
[23:31:05.789] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:05.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:52:0) after 1m0s
[23:32:05.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:52:0)
[23:32:05.925] Timer tick, asking Buildbucket for the build status
[23:32:06.225] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:06.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:53:0) after 1m0s
[23:33:06.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:53:0)
[23:33:06.269] Timer tick, asking Buildbucket for the build status
[23:33:06.566] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:06.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:54:0) after 1m0s
[23:34:06.727] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:54:0)
[23:34:06.727] Timer tick, asking Buildbucket for the build status
[23:34:07.113] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:07.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:55:0) after 1m0s
[23:35:07.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:55:0)
[23:35:07.146] Timer tick, asking Buildbucket for the build status
[23:35:07.223] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:07.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:56:0) after 1m0s
[23:36:07.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:56:0)
[23:36:07.293] Timer tick, asking Buildbucket for the build status
[23:36:07.521] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:07.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:57:0) after 1m0s
[23:37:07.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:57:0)
[23:37:07.557] Timer tick, asking Buildbucket for the build status
[23:37:07.658] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:07.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:58:0) after 1m0s
[23:38:07.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:58:0)
[23:38:07.826] Timer tick, asking Buildbucket for the build status
[23:38:07.930] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:07.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:59:0) after 1m0s
[23:39:08.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:59:0)
[23:39:08.064] Timer tick, asking Buildbucket for the build status
[23:39:08.220] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:08.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:60:0) after 1m0s
[23:40:08.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:60:0)
[23:40:08.254] Timer tick, asking Buildbucket for the build status
[23:40:08.391] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:08.391] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:61:0) after 1m0s
[23:41:09.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:61:0)
[23:41:09.061] Timer tick, asking Buildbucket for the build status
[23:41:09.208] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:09.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:62:0) after 1m0s
[23:42:09.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:62:0)
[23:42:09.392] Timer tick, asking Buildbucket for the build status
[23:42:09.606] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:09.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:63:0) after 1m0s
[23:43:09.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:63:0)
[23:43:09.621] Timer tick, asking Buildbucket for the build status
[23:43:09.717] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:09.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:64:0) after 1m0s
[23:44:09.799] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:64:0)
[23:44:09.799] Timer tick, asking Buildbucket for the build status
[23:44:10.099] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:10.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:65:0) after 1m0s
[23:45:10.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:65:0)
[23:45:10.123] Timer tick, asking Buildbucket for the build status
[23:45:10.243] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:10.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:66:0) after 1m0s
[23:46:10.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:66:0)
[23:46:10.263] Timer tick, asking Buildbucket for the build status
[23:46:10.601] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:10.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:67:0) after 1m0s
[23:47:10.675] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:67:0)
[23:47:10.675] Timer tick, asking Buildbucket for the build status
[23:47:10.809] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:10.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:68:0) after 1m0s
[23:48:10.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:68:0)
[23:48:10.857] Timer tick, asking Buildbucket for the build status
[23:48:11.117] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:11.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:69:0) after 1m0s
[23:49:11.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:69:0)
[23:49:11.237] Timer tick, asking Buildbucket for the build status
[23:49:11.320] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:11.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:70:0) after 1m0s
[23:50:12.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:70:0)
[23:50:12.125] Timer tick, asking Buildbucket for the build status
[23:50:12.249] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:12.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:71:0) after 1m0s
[23:51:12.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:71:0)
[23:51:12.295] Timer tick, asking Buildbucket for the build status
[23:51:12.383] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:12.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:72:0) after 1m0s
[23:52:12.437] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:72:0)
[23:52:12.437] Timer tick, asking Buildbucket for the build status
[23:52:12.541] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:12.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:73:0) after 1m0s
[23:53:12.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:73:0)
[23:53:12.644] Timer tick, asking Buildbucket for the build status
[23:53:12.728] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:12.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:74:0) after 1m0s
[23:54:12.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:74:0)
[23:54:12.772] Timer tick, asking Buildbucket for the build status
[23:54:13.066] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:13.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:75:0) after 1m0s
[23:55:13.189] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:75:0)
[23:55:13.189] Timer tick, asking Buildbucket for the build status
[23:55:13.316] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:13.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:76:0) after 1m0s
[23:56:13.354] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:76:0)
[23:56:13.354] Timer tick, asking Buildbucket for the build status
[23:56:13.682] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:13.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:77:0) after 1m0s
[23:57:13.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:77:0)
[23:57:13.752] Timer tick, asking Buildbucket for the build status
[23:57:13.858] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:13.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:78:0) after 1m0s
[23:58:13.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:78:0)
[23:58:13.879] Timer tick, asking Buildbucket for the build status
[23:58:14.043] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:14.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:79:0) after 1m0s
[23:59:14.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:79:0)
[23:59:14.048] Timer tick, asking Buildbucket for the build status
[23:59:14.128] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:14.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:80:0) after 1m0s
[00:00:14.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:80:0)
[00:00:14.206] Timer tick, asking Buildbucket for the build status
[00:00:14.379] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:14.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:81:0) after 1m0s
[00:01:14.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:81:0)
[00:01:14.440] Timer tick, asking Buildbucket for the build status
[00:01:14.523] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:14.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:82:0) after 1m0s
[00:02:14.550] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:82:0)
[00:02:14.550] Timer tick, asking Buildbucket for the build status
[00:02:14.866] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:14.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:83:0) after 1m0s
[00:03:14.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:83:0)
[00:03:14.880] Timer tick, asking Buildbucket for the build status
[00:03:14.989] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:14.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:84:0) after 1m0s
[00:04:14.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:84:0)
[00:04:14.993] Timer tick, asking Buildbucket for the build status
[00:04:15.157] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:15.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:85:0) after 1m0s
[00:05:15.181] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:85:0)
[00:05:15.181] Timer tick, asking Buildbucket for the build status
[00:05:15.315] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:15.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:86:0) after 1m0s
[00:06:15.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:86:0)
[00:06:15.288] Timer tick, asking Buildbucket for the build status
[00:06:15.587] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:15.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:87:0) after 1m0s
[00:07:15.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:87:0)
[00:07:15.614] Timer tick, asking Buildbucket for the build status
[00:07:15.703] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:15.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:88:0) after 1m0s
[00:08:15.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:88:0)
[00:08:15.737] Timer tick, asking Buildbucket for the build status
[00:08:16.038] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:16.038] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:89:0) after 1m0s
[00:09:16.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:89:0)
[00:09:16.059] Timer tick, asking Buildbucket for the build status
[00:09:16.142] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:16.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:90:0) after 1m0s
[00:10:16.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:90:0)
[00:10:16.152] Timer tick, asking Buildbucket for the build status
[00:10:16.308] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:16.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:91:0) after 1m0s
[00:11:16.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:91:0)
[00:11:16.389] Timer tick, asking Buildbucket for the build status
[00:11:16.490] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:16.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:92:0) after 1m0s
[00:12:16.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:92:0)
[00:12:16.530] Timer tick, asking Buildbucket for the build status
[00:12:16.641] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:16.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:93:0) after 1m0s
[00:13:16.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:93:0)
[00:13:16.664] Timer tick, asking Buildbucket for the build status
[00:13:17.027] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:17.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:94:0) after 1m0s
[00:14:17.057] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:94:0)
[00:14:17.057] Timer tick, asking Buildbucket for the build status
[00:14:17.215] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:17.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:95:0) after 1m0s
[00:15:17.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:95:0)
[00:15:17.248] Timer tick, asking Buildbucket for the build status
[00:15:17.455] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:17.455] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:96:0) after 1m0s
[00:16:17.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:96:0)
[00:16:17.468] Timer tick, asking Buildbucket for the build status
[00:16:17.652] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:17.652] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:97:0) after 1m0s
[00:17:17.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:97:0)
[00:17:17.694] Timer tick, asking Buildbucket for the build status
[00:17:17.802] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:17.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:98:0) after 1m0s
[00:18:17.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:98:0)
[00:18:17.851] Timer tick, asking Buildbucket for the build status
[00:18:18.337] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:18.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:99:0) after 1m0s
[00:19:18.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:99:0)
[00:19:18.398] Timer tick, asking Buildbucket for the build status
[00:19:19.042] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:19.042] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:100:0) after 1m0s
[00:20:19.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:100:0)
[00:20:19.121] Timer tick, asking Buildbucket for the build status
[00:20:19.215] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:19.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:101:0) after 1m0s
[00:21:19.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:101:0)
[00:21:19.298] Timer tick, asking Buildbucket for the build status
[00:21:19.501] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:19.501] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:102:0) after 1m0s
[00:22:19.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:102:0)
[00:22:19.591] Timer tick, asking Buildbucket for the build status
[00:22:20.087] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:20.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:103:0) after 1m0s
[00:23:20.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:103:0)
[00:23:20.139] Timer tick, asking Buildbucket for the build status
[00:23:20.477] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:20.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:104:0) after 1m0s
[00:24:20.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:104:0)
[00:24:20.477] Timer tick, asking Buildbucket for the build status
[00:24:20.843] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:20.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:105:0) after 1m0s
[00:25:21.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:105:0)
[00:25:21.005] Timer tick, asking Buildbucket for the build status
[00:25:21.208] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:21.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:106:0) after 1m0s
[00:26:21.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:106:0)
[00:26:21.278] Timer tick, asking Buildbucket for the build status
[00:26:21.386] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:21.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:107:0) after 1m0s
[00:27:21.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:107:0)
[00:27:21.431] Timer tick, asking Buildbucket for the build status
[00:27:21.795] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:21.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:108:0) after 1m0s
[00:28:22.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:108:0)
[00:28:22.022] Timer tick, asking Buildbucket for the build status
[00:28:22.211] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:22.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:109:0) after 1m0s
[00:29:22.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:109:0)
[00:29:22.257] Timer tick, asking Buildbucket for the build status
[00:29:22.353] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:22.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:110:0) after 1m0s
[00:30:22.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:110:0)
[00:30:22.440] Timer tick, asking Buildbucket for the build status
[00:30:22.535] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:22.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:111:0) after 1m0s
[00:31:22.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:111:0)
[00:31:22.565] Timer tick, asking Buildbucket for the build status
[00:31:22.684] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:22.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:112:0) after 1m0s
[00:32:22.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:112:0)
[00:32:22.698] Timer tick, asking Buildbucket for the build status
[00:32:22.813] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:22.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:113:0) after 1m0s
[00:33:22.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:113:0)
[00:33:22.923] Timer tick, asking Buildbucket for the build status
[00:33:23.211] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:23.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:114:0) after 1m0s
[00:34:23.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:114:0)
[00:34:23.291] Timer tick, asking Buildbucket for the build status
[00:34:23.519] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:23.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:115:0) after 1m0s
[00:35:23.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:115:0)
[00:35:23.604] Timer tick, asking Buildbucket for the build status
[00:35:24.084] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:24.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:116:0) after 1m0s
[00:36:24.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:116:0)
[00:36:24.213] Timer tick, asking Buildbucket for the build status
[00:36:24.306] Build 8854556710819160464: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:24.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019986772855012624:117:0) after 1m0s
[00:36:30.420] Received PubSub notification, asking Buildbucket for the build status
[00:36:30.507] Build 8854556710819160464: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:36:30.507] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614040587501645",
"created_by": "project:chromium",
"created_ts": "1614033703937158",
"id": "8854556710819160464",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\"}}",
"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\": \"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\", \"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-east1-d-8-76-83di\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22735, \"got_angle_revision\": \"4a95488c0edfb4590c808ee01079069da5a6b2b1\", \"got_dawn_revision\": \"2d3c2e355337037dfa6873536bfb3e3a558bf9ed\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\", \"got_revision_cp\": \"refs/heads/master@{#856477}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"3ffbd62bb3437e4b12fdf8ee1dd7a3eb8a5d27ee\", \"got_v8_revision\": \"47f385bf2cd19da4cb3cebc6ff3186859728a2fd\", \"got_v8_revision_cp\": \"refs/heads/9.0.236@{#1}\", \"got_webrtc_revision\": \"28547e96cc2b1be9ebdea7455c46f12fe76d90c7\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33318}\", \"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\": \"7221bb9f86b76bb19393dd4f213422a1da2a6ff1\", \"swarm_hashes_refs/heads/master(at){#856477}_without_patch\": {\"absl_hardening_tests\": \"fb7179794b799b25eb20ebb5f6585cdc80cc0823\", \"accessibility_unittests\": \"27e9b484caaeb96b9431f181c2a8259dfe893060\", \"angle_unittests\": \"f684f4bcd69ff84de9db01cba06f054204ef5fc9\", \"app_list_unittests\": \"81052130a1c86ed235c441509075d2c87b0eb5bc\", \"app_shell_unittests\": \"a0aa0a6a051c768b777d7db25e1f37caa0cc5424\", \"ash_unittests\": \"c27a95a268bdd4fde3bfd31f7da34d8ef1d8766d\", \"aura_unittests\": \"9f16125208eb23c161e92e0b5ef1d7ff57b33c5b\", \"base_unittests\": \"14f16f94834ebe4a02d7b39d35835cb20425f961\", \"base_util_unittests\": \"f1a584fc6a38c45970fc8d525f8658adda995c4b\", \"blink_common_unittests\": \"ba0f0e36f7c494845a6b66f50469672da1612797\", \"blink_fuzzer_unittests\": \"60fc423a6f85a76260a83ac046af0c9adb323573\", \"blink_heap_unittests\": \"d372e597dd5123c2aed0ad2b4b5ff3b8c93a6351\", \"blink_platform_unittests\": \"33f4e4c7f6b02022b21231a9f8cd343da7e33dc7\", \"blink_unittests\": \"f240260e215fc0815c3faa591b07ab238275eba8\", \"boringssl_crypto_tests\": \"704da98d97c5ea67ea567ce49d22de8700475ae9\", \"boringssl_ssl_tests\": \"6713c49a5248f2bf6fc7050f9b00cc6f6ea14fd0\", \"browser_tests\": \"85b96e2ff6afeb5f771cd43388adf5905ddaec21\", \"capture_unittests\": \"7b80557038a536571b09165d43a21a85a8613e05\", \"cast_unittests\": \"dbe790f776b3931d9f60f277a79fc77f02d85afa\", \"cc_unittests\": \"6bb78c53652315c6cecfabd3eb1d5ee9371b135d\", \"chrome_app_unittests\": \"f94089f175b396bd934909eacae2451ac59ee775\", \"chromedriver_unittests\": \"58d3df1a42a0e9e8d6ba9b31cbcb06da22c5895d\", \"chromeos_components_unittests\": \"f12f3c2ec68c17c89fb38c6d1d939620b66d6fb7\", \"chromeos_unittests\": \"2a601757893b1bafbd43b16722fb2ba5e188846c\", \"components_browsertests\": \"9d58513e9a933c70b5ab80281e5c88ee130f7f04\", \"components_unittests\": \"5bce2f230c46d33eb90b0b6cd7cef08772f1946a\", \"compositor_unittests\": \"ad65cf42b63ef2a044b5f51f8c456ec76b818f70\", \"content_browsertests\": \"bd87de7d65318bcef60a4e2faf0b88f2db729f35\", \"content_unittests\": \"290261c4ee1da688cdb5e2a9640bf3721b36af25\", \"crashpad_tests\": \"effc2f6a7faa154748146f1d128a31ba40f81f15\", \"crypto_unittests\": \"7337ff81c12b72e505556d5155e535f2959cda1a\", \"dbus_unittests\": \"347a9e8ba566def417434fdc66c0821df0e3cdc0\", \"device_unittests\": \"216553bd5e17b4c874e47dddc1e74ea582dc0384\", \"display_unittests\": \"6ddfbf3931e2f9dc81c82cc65ea4c148cffefffa\", \"events_unittests\": \"6e1f9d0e8d99bb57c462c4912ff84eb041646f5f\", \"exo_unittests\": \"ff16a1b645ef1d865c22df1295d5e6efbebd3cf5\", \"extensions_browsertests\": \"e46439e3f9d1c672992d9e0d11830e037af56767\", \"extensions_unittests\": \"01a2b4f9802e82f351b2df8310a6050d9a6d8daa\", \"filesystem_service_unittests\": \"362abc25ca61fc2f18929ab674cfaf3eaa234781\", \"gcm_unit_tests\": \"8d3200910ee8cfc6417b137675af88018d412027\", \"gfx_unittests\": \"e05a8bae229caf609ebc1ec140a2f7c46a68dfdc\", \"gin_unittests\": \"a8c9fd4562acd8f1a3d73d544663e53490ededb5\", \"gl_unittests_ozone\": \"09f827295758c9197c6cf6e837882bd6622f9cd4\", \"google_apis_unittests\": \"4d6ba0796b13f772cfe0ac9e6f14313503d34a36\", \"gpu_unittests\": \"3b31e1f749407fd0efeb8689019f3e4adbcac2db\", \"gwp_asan_unittests\": \"133a8ea15c806fbea01ed1f91530baa87405329d\", \"interactive_ui_tests\": \"7077dafaa54bc3b671d5d662b9ec064c4550aed4\", \"ipc_tests\": \"a995e57e45088ede697bdf75b47048954c532376\", \"jingle_unittests\": \"95805eee399c0ebe34fb76e650c5cec530f2a6ba\", \"keyboard_unittests\": \"59ccad2ef442c367f111ff6c9d07f825ebd16a40\", \"latency_unittests\": \"80fced1cabcc0f17463eeee0cd5f3362c201b1bf\", \"libjingle_xmpp_unittests\": \"fe3571346afeaaa8512735261cd17e02a2eb952f\", \"liburlpattern_unittests\": \"266ef4aca9ea061f9be3c6c33d9940bdae61dd53\", \"media_blink_unittests\": \"d4e1f90300e7266cca461aff1c49a56d57d59ec3\", \"media_unittests\": \"3f07b22a03a6b0f95a8ada7a45d75a3b64a8df5e\", \"message_center_unittests\": \"014e53723b3e8586628371a79a7ec70a0d578a7d\", \"midi_unittests\": \"ca6f350039ebcc488689a428712ae0b5e01ae8b3\", \"mojo_core_unittests\": \"23b2572cf21e73de418fe100ac92375fd42c9b96\", \"mojo_unittests\": \"4c69b72fcca559e9356067860528c2e9deee6310\", \"nacl_helper_nonsfi_unittests\": \"e4a0976852413f7f1458dbe2bd1fbdea1323c0f0\", \"nacl_loader_unittests\": \"9e43d148f03f322d4bb0d94b30ea170833048b49\", \"native_theme_unittests\": \"5316479c35bf84774979b08b1378f337f25f9f9d\", \"net_unittests\": \"55f783a9d43ce17d08ae5b4722808b79f365c045\", \"ozone_gl_unittests\": \"27aea2bf7f675884a84bb1b0d7e379ab9b3688b4\", \"ozone_unittests\": \"8202941410998d82f5e3fdecff92e6116543b54a\", \"ozone_x11_unittests\": \"0833ad7f4600fd3757444a4a99971f3bf9673252\", \"pdf_unittests\": \"45f1d2e6c53f3a70ba7c8f46cb4baea1b4d22329\", \"perfetto_unittests\": \"cec664da0dd6b877b61d982c59e3962cbe8d6b1f\", \"ppapi_unittests\": \"291f6475ba29c79530aa90657029e37ec5252ff3\", \"printing_unittests\": \"bf5c633bbbc8996f61eb8beed24b6dda2fb6e5e3\", \"remoting_unittests\": \"d4ea773583cf063b4fcae2ebd3418e2737513f49\", \"sandbox_linux_unittests\": \"7e95c61a1a31e3d80332599a38fb531f3559b8ce\", \"service_manager_unittests\": \"25c1389d09f25056202d1902d4535af685b0b4b5\", \"services_unittests\": \"a75b8a6e65fb6c768fb9a10fc04e7c6a3f4c0584\", \"shell_dialogs_unittests\": \"46aef6fabe848d17eb1fa5665d5a7c1f668dc427\", \"shell_encryption_unittests\": \"ed3652c1375fecf5ec8e412dc7825cb196339e0e\", \"skia_unittests\": \"fa46ee39abb21cd64290ad51b4a5247d094b642e\", \"snapshot_unittests\": \"4d9264f737ebb09acabac7f2b00a54d324977529\", \"sql_unittests\": \"73215b9d2479e227efc122a0f7b4dc79a335a209\", \"storage_unittests\": \"84e2a0a61a385667fd3f249601ef6a4675e7ea21\", \"sync_integration_tests\": \"8c023f1cf830a4c8efaf89cbdb9034aa2b9dc4a1\", \"traffic_annotation_auditor_unittests\": \"e2ebeb8dea795bd29c763428c6c266f880e3df8d\", \"ui_base_unittests\": \"5b0112c604bca86fb608d3cc149b7f0ef836725c\", \"ui_chromeos_unittests\": \"07ab85b62216f2e79317e7caf541802a07f95408\", \"ui_touch_selection_unittests\": \"e5d07c5ae0eef26b6c3693c73175f7b0c8841bfe\", \"unit_tests\": \"9a90cd5d91daad83ef1946a6d07f0e1d1ac1b8cf\", \"url_unittests\": \"94d7bf1fa3e38c78de3b17a6ffd54f167032d8c3\", \"usage_time_limit_unittests\": \"c036b0499b6e81c213b72d0e18d44169c9abf57f\", \"views_unittests\": \"13374cf1051541b9d092b044035aa8355f285dc0\", \"viz_unittests\": \"e21c4152e0069ee0ff5de20571ef2ad59fe48416\", \"wm_unittests\": \"71a7e37760d6d192104d75c09e672da77f2a8c12\", \"wtf_unittests\": \"1b72d229f78ee13b637c4e50d79e832f8f113966\", \"zlib_unittests\": \"1fbd5af3b32f0f0f683ec4c02fa650d4b77df371\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-east1-d-8-76-83di\"], \"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\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614033735159428",
"status": "COMPLETED",
"status_changed_ts": "1614040588249388",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22735",
"builder:linux-chromeos-dbg",
"buildset:commit/git/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7221bb9f86b76bb19393dd4f213422a1da2a6ff1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019986772855012624",
"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/8854556710819160464/+/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:51e4b95fa8dba410",
"user_agent:luci-scheduler"
],
"updated_ts": "1614040588330408",
"url": "https://ci.chromium.org/b/8854556710819160464",
"utcnow_ts": "1614040590500325"
}
}
[00:36:30.507] Invocation finished in 1h54m47.895218007s with status SUCCEEDED