[20:30:21.454] New invocation is queued and will start shortly
[20:30:23.705] Starting the invocation (attempt 1)
[20:30:23.758] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:30:23.758] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:30:23.758] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021897573165479408",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"71068dfd2c15142503a57d7fd73f9f9670e3399a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021897573165479408",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"gitiles_ref:refs/heads/master"
]
}
[20:30:26.048] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612211423910150",
"id": "8856467509920306864",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"71068dfd2c15142503a57d7fd73f9f9670e3399a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612211425627352",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22434",
"builder:linux-chromeos-dbg",
"buildset:commit/git/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021897573165479408",
"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/8856467509920306864/+/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": "1612211425635248",
"url": "https://ci.chromium.org/b/8856467509920306864",
"utcnow_ts": "1612211426012745"
}
}
[20:30:26.048] Task URL: https://ci.chromium.org/b/8856467509920306864
[20:30:26.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:2:0) after 1m0s
[20:30:27.888] Received PubSub notification, asking Buildbucket for the build status
[20:30:27.957] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:26.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:2:0)
[20:31:26.141] Timer tick, asking Buildbucket for the build status
[20:31:26.625] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:26.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:4:0) after 1m0s
[20:32:26.757] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:4:0)
[20:32:26.757] Timer tick, asking Buildbucket for the build status
[20:32:26.826] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:26.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:5:0) after 1m0s
[20:33:26.864] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:5:0)
[20:33:26.864] Timer tick, asking Buildbucket for the build status
[20:33:27.444] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:27.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:6:0) after 1m0s
[20:34:27.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:6:0)
[20:34:27.646] Timer tick, asking Buildbucket for the build status
[20:34:27.814] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:27.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:7:0) after 1m0s
[20:35:27.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:7:0)
[20:35:27.872] Timer tick, asking Buildbucket for the build status
[20:35:28.092] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:28.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:8:0) after 1m0s
[20:36:28.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:8:0)
[20:36:28.211] Timer tick, asking Buildbucket for the build status
[20:36:28.357] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:28.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:9:0) after 1m0s
[20:37:28.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:9:0)
[20:37:28.394] Timer tick, asking Buildbucket for the build status
[20:37:28.467] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:28.467] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:10:0) after 1m0s
[20:38:28.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:10:0)
[20:38:28.562] Timer tick, asking Buildbucket for the build status
[20:38:28.622] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:28.622] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:11:0) after 1m0s
[20:39:28.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:11:0)
[20:39:28.661] Timer tick, asking Buildbucket for the build status
[20:39:28.767] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:28.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:12:0) after 1m0s
[20:40:28.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:12:0)
[20:40:28.853] Timer tick, asking Buildbucket for the build status
[20:40:29.035] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:29.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:13:0) after 1m0s
[20:41:29.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:13:0)
[20:41:29.068] Timer tick, asking Buildbucket for the build status
[20:41:29.171] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:29.171] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:14:0) after 1m0s
[20:42:29.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:14:0)
[20:42:29.244] Timer tick, asking Buildbucket for the build status
[20:42:29.300] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:29.300] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:15:0) after 1m0s
[20:43:29.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:15:0)
[20:43:29.406] Timer tick, asking Buildbucket for the build status
[20:43:29.494] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:29.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:16:0) after 1m0s
[20:44:29.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:16:0)
[20:44:29.712] Timer tick, asking Buildbucket for the build status
[20:44:29.819] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:29.820] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:17:0) after 1m0s
[20:45:29.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:17:0)
[20:45:29.884] Timer tick, asking Buildbucket for the build status
[20:45:30.053] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:30.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:18:0) after 1m0s
[20:46:30.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:18:0)
[20:46:30.139] Timer tick, asking Buildbucket for the build status
[20:46:30.211] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:30.212] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:19:0) after 1m0s
[20:47:30.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:19:0)
[20:47:30.293] Timer tick, asking Buildbucket for the build status
[20:47:30.368] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:30.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:20:0) after 1m0s
[20:48:30.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:20:0)
[20:48:30.506] Timer tick, asking Buildbucket for the build status
[20:48:30.579] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:30.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:21:0) after 1m0s
[20:49:30.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:21:0)
[20:49:30.661] Timer tick, asking Buildbucket for the build status
[20:49:30.827] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:30.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:22:0) after 1m0s
[20:50:30.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:22:0)
[20:50:30.923] Timer tick, asking Buildbucket for the build status
[20:50:31.226] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:31.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:23:0) after 1m0s
[20:51:31.322] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:23:0)
[20:51:31.322] Timer tick, asking Buildbucket for the build status
[20:51:31.415] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:31.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:24:0) after 1m0s
[20:52:31.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:24:0)
[20:52:31.516] Timer tick, asking Buildbucket for the build status
[20:52:31.606] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:31.606] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:25:0) after 1m0s
[20:53:31.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:25:0)
[20:53:31.691] Timer tick, asking Buildbucket for the build status
[20:53:31.774] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:31.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:26:0) after 1m0s
[20:54:31.876] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:26:0)
[20:54:31.876] Timer tick, asking Buildbucket for the build status
[20:54:31.969] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:31.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:27:0) after 1m0s
[20:55:32.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:27:0)
[20:55:32.030] Timer tick, asking Buildbucket for the build status
[20:55:32.574] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:32.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:28:0) after 1m0s
[20:56:32.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:28:0)
[20:56:32.640] Timer tick, asking Buildbucket for the build status
[20:56:32.958] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:32.958] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:29:0) after 1m0s
[20:57:33.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:29:0)
[20:57:33.086] Timer tick, asking Buildbucket for the build status
[20:57:34.025] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:34.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:30:0) after 1m0s
[20:58:34.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:30:0)
[20:58:34.027] Timer tick, asking Buildbucket for the build status
[20:58:34.717] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:34.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:31:0) after 1m0s
[20:59:34.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:31:0)
[20:59:34.896] Timer tick, asking Buildbucket for the build status
[20:59:35.112] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:35.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:32:0) after 1m0s
[21:00:35.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:32:0)
[21:00:35.276] Timer tick, asking Buildbucket for the build status
[21:00:35.709] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:35.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:33:0) after 1m0s
[21:01:35.803] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:33:0)
[21:01:35.803] Timer tick, asking Buildbucket for the build status
[21:01:35.917] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:35.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:34:0) after 1m0s
[21:02:36.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:34:0)
[21:02:36.065] Timer tick, asking Buildbucket for the build status
[21:02:36.133] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:36.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:35:0) after 1m0s
[21:03:36.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:35:0)
[21:03:36.136] Timer tick, asking Buildbucket for the build status
[21:03:36.541] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:36.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:36:0) after 1m0s
[21:04:36.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:36:0)
[21:04:36.596] Timer tick, asking Buildbucket for the build status
[21:04:36.678] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:36.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:37:0) after 1m0s
[21:05:36.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:37:0)
[21:05:36.688] Timer tick, asking Buildbucket for the build status
[21:05:36.995] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:36.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:38:0) after 1m0s
[21:06:37.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:38:0)
[21:06:37.074] Timer tick, asking Buildbucket for the build status
[21:06:37.225] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:37.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:39:0) after 1m0s
[21:07:37.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:39:0)
[21:07:37.294] Timer tick, asking Buildbucket for the build status
[21:07:37.436] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:37.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:40:0) after 1m0s
[21:08:37.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:40:0)
[21:08:37.463] Timer tick, asking Buildbucket for the build status
[21:08:37.530] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:37.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:41:0) after 1m0s
[21:09:37.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:41:0)
[21:09:37.531] Timer tick, asking Buildbucket for the build status
[21:09:37.659] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:37.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:42:0) after 1m0s
[21:10:37.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:42:0)
[21:10:37.699] Timer tick, asking Buildbucket for the build status
[21:10:37.981] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:37.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:43:0) after 1m0s
[21:11:38.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:43:0)
[21:11:38.046] Timer tick, asking Buildbucket for the build status
[21:11:38.325] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:38.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:44:0) after 1m0s
[21:12:38.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:44:0)
[21:12:38.378] Timer tick, asking Buildbucket for the build status
[21:12:38.854] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:38.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:45:0) after 1m0s
[21:13:38.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:45:0)
[21:13:38.998] Timer tick, asking Buildbucket for the build status
[21:13:39.162] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:39.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:46:0) after 1m0s
[21:14:39.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:46:0)
[21:14:39.165] Timer tick, asking Buildbucket for the build status
[21:14:39.280] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:39.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:47:0) after 1m0s
[21:15:39.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:47:0)
[21:15:39.389] Timer tick, asking Buildbucket for the build status
[21:15:39.537] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:39.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:48:0) after 1m0s
[21:16:39.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:48:0)
[21:16:39.637] Timer tick, asking Buildbucket for the build status
[21:16:39.762] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:39.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:49:0) after 1m0s
[21:17:39.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:49:0)
[21:17:39.781] Timer tick, asking Buildbucket for the build status
[21:17:40.109] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:40.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:50:0) after 1m0s
[21:18:40.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:50:0)
[21:18:40.128] Timer tick, asking Buildbucket for the build status
[21:18:40.607] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:40.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:51:0) after 1m0s
[21:19:40.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:51:0)
[21:19:40.648] Timer tick, asking Buildbucket for the build status
[21:19:40.745] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:40.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:52:0) after 1m0s
[21:20:40.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:52:0)
[21:20:40.764] Timer tick, asking Buildbucket for the build status
[21:20:40.923] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:40.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:53:0) after 1m0s
[21:21:40.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:53:0)
[21:21:40.965] Timer tick, asking Buildbucket for the build status
[21:21:41.053] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:41.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:54:0) after 1m0s
[21:22:41.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:54:0)
[21:22:41.061] Timer tick, asking Buildbucket for the build status
[21:22:41.151] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:41.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:55:0) after 1m0s
[21:23:41.374] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:55:0)
[21:23:41.374] Timer tick, asking Buildbucket for the build status
[21:23:41.537] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:41.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:56:0) after 1m0s
[21:24:41.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:56:0)
[21:24:41.620] Timer tick, asking Buildbucket for the build status
[21:24:41.703] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:41.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:57:0) after 1m0s
[21:25:41.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:57:0)
[21:25:41.735] Timer tick, asking Buildbucket for the build status
[21:25:41.873] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:41.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:58:0) after 1m0s
[21:26:41.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:58:0)
[21:26:41.960] Timer tick, asking Buildbucket for the build status
[21:26:42.081] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:42.081] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:59:0) after 1m0s
[21:27:42.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:59:0)
[21:27:42.184] Timer tick, asking Buildbucket for the build status
[21:27:42.264] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:42.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:60:0) after 1m0s
[21:28:42.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:60:0)
[21:28:42.319] Timer tick, asking Buildbucket for the build status
[21:28:42.392] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:42.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:61:0) after 1m0s
[21:29:42.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:61:0)
[21:29:42.418] Timer tick, asking Buildbucket for the build status
[21:29:42.899] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:42.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:62:0) after 1m0s
[21:30:42.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:62:0)
[21:30:42.950] Timer tick, asking Buildbucket for the build status
[21:30:43.132] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:43.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:63:0) after 1m0s
[21:31:43.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:63:0)
[21:31:43.299] Timer tick, asking Buildbucket for the build status
[21:31:43.414] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:43.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:64:0) after 1m0s
[21:32:43.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:64:0)
[21:32:43.481] Timer tick, asking Buildbucket for the build status
[21:32:43.569] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:43.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:65:0) after 1m0s
[21:33:43.635] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:65:0)
[21:33:43.635] Timer tick, asking Buildbucket for the build status
[21:33:43.798] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:43.798] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:66:0) after 1m0s
[21:34:43.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:66:0)
[21:34:43.826] Timer tick, asking Buildbucket for the build status
[21:34:44.237] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:67:0) after 1m0s
[21:35:44.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:67:0)
[21:35:44.318] Timer tick, asking Buildbucket for the build status
[21:35:44.433] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:44.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:68:0) after 1m0s
[21:36:45.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:68:0)
[21:36:45.119] Timer tick, asking Buildbucket for the build status
[21:36:45.399] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:45.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:69:0) after 1m0s
[21:37:45.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:69:0)
[21:37:45.949] Timer tick, asking Buildbucket for the build status
[21:37:46.027] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:46.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:70:0) after 1m0s
[21:38:46.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:70:0)
[21:38:46.172] Timer tick, asking Buildbucket for the build status
[21:38:46.258] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:46.258] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:71:0) after 1m0s
[21:39:46.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:71:0)
[21:39:46.382] Timer tick, asking Buildbucket for the build status
[21:39:46.466] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:46.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:72:0) after 1m0s
[21:40:46.685] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:72:0)
[21:40:46.685] Timer tick, asking Buildbucket for the build status
[21:40:46.849] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:46.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:73:0) after 1m0s
[21:41:47.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:73:0)
[21:41:47.119] Timer tick, asking Buildbucket for the build status
[21:41:47.218] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:47.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:74:0) after 1m0s
[21:42:47.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:74:0)
[21:42:47.603] Timer tick, asking Buildbucket for the build status
[21:42:47.683] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:47.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:75:0) after 1m0s
[21:43:48.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:75:0)
[21:43:48.007] Timer tick, asking Buildbucket for the build status
[21:43:48.229] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:48.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:76:0) after 1m0s
[21:44:48.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:76:0)
[21:44:48.352] Timer tick, asking Buildbucket for the build status
[21:44:48.516] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:48.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:77:0) after 1m0s
[21:45:48.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:77:0)
[21:45:48.588] Timer tick, asking Buildbucket for the build status
[21:45:48.693] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:48.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:78:0) after 1m0s
[21:46:48.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:78:0)
[21:46:48.845] Timer tick, asking Buildbucket for the build status
[21:46:48.977] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:48.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:79:0) after 1m0s
[21:47:49.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:79:0)
[21:47:49.128] Timer tick, asking Buildbucket for the build status
[21:47:49.235] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:49.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:80:0) after 1m0s
[21:48:49.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:80:0)
[21:48:49.301] Timer tick, asking Buildbucket for the build status
[21:48:49.387] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:49.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:81:0) after 1m0s
[21:49:49.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:81:0)
[21:49:49.406] Timer tick, asking Buildbucket for the build status
[21:49:49.488] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:49.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:82:0) after 1m0s
[21:50:49.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:82:0)
[21:50:49.557] Timer tick, asking Buildbucket for the build status
[21:50:49.667] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:49.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:83:0) after 1m0s
[21:51:49.735] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:83:0)
[21:51:49.735] Timer tick, asking Buildbucket for the build status
[21:51:49.806] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:49.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:84:0) after 1m0s
[21:52:49.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:84:0)
[21:52:49.879] Timer tick, asking Buildbucket for the build status
[21:52:50.273] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:50.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:85:0) after 1m0s
[21:53:50.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:85:0)
[21:53:50.320] Timer tick, asking Buildbucket for the build status
[21:53:50.393] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:50.393] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:86:0) after 1m0s
[21:54:50.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:86:0)
[21:54:50.483] Timer tick, asking Buildbucket for the build status
[21:54:51.009] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:51.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:87:0) after 1m0s
[21:55:51.123] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:87:0)
[21:55:51.123] Timer tick, asking Buildbucket for the build status
[21:55:51.255] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:51.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:88:0) after 1m0s
[21:56:51.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:88:0)
[21:56:51.245] Timer tick, asking Buildbucket for the build status
[21:56:51.315] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:51.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:89:0) after 1m0s
[21:57:51.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:89:0)
[21:57:51.342] Timer tick, asking Buildbucket for the build status
[21:57:51.413] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:51.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:90:0) after 1m0s
[21:58:51.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:90:0)
[21:58:51.521] Timer tick, asking Buildbucket for the build status
[21:58:51.658] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:51.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:91:0) after 1m0s
[21:59:51.923] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:91:0)
[21:59:51.923] Timer tick, asking Buildbucket for the build status
[21:59:52.223] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:52.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:92:0) after 1m0s
[22:00:52.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:92:0)
[22:00:52.275] Timer tick, asking Buildbucket for the build status
[22:00:52.545] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:52.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:93:0) after 1m0s
[22:01:52.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:93:0)
[22:01:52.630] Timer tick, asking Buildbucket for the build status
[22:01:52.704] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:52.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:94:0) after 1m0s
[22:02:52.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:94:0)
[22:02:52.798] Timer tick, asking Buildbucket for the build status
[22:02:52.948] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:52.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:95:0) after 1m0s
[22:03:53.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:95:0)
[22:03:53.117] Timer tick, asking Buildbucket for the build status
[22:03:53.215] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:53.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:96:0) after 1m0s
[22:04:53.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:96:0)
[22:04:53.329] Timer tick, asking Buildbucket for the build status
[22:04:53.403] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:53.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:97:0) after 1m0s
[22:05:53.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:97:0)
[22:05:53.516] Timer tick, asking Buildbucket for the build status
[22:05:54.423] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:54.423] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:98:0) after 1m0s
[22:06:54.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:98:0)
[22:06:54.466] Timer tick, asking Buildbucket for the build status
[22:06:54.536] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:54.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:99:0) after 1m0s
[22:07:54.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:99:0)
[22:07:54.560] Timer tick, asking Buildbucket for the build status
[22:07:54.624] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:54.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:100:0) after 1m0s
[22:08:55.002] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:100:0)
[22:08:55.002] Timer tick, asking Buildbucket for the build status
[22:08:55.133] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:55.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:101:0) after 1m0s
[22:09:55.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:101:0)
[22:09:55.213] Timer tick, asking Buildbucket for the build status
[22:09:55.325] Build 8856467509920306864: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:55.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021897573165479408:102:0) after 1m0s
[22:10:53.335] Received PubSub notification, asking Buildbucket for the build status
[22:10:53.417] Build 8856467509920306864: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[22:10:53.417] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612217452377286",
"created_by": "project:chromium",
"created_ts": "1612211423910150",
"id": "8856467509920306864",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"71068dfd2c15142503a57d7fd73f9f9670e3399a\"}}",
"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\": \"71068dfd2c15142503a57d7fd73f9f9670e3399a\", \"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-93-pui4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22434, \"got_angle_revision\": \"e3096d0729df059f1d251405d16eef9e71ba2516\", \"got_dawn_revision\": \"d7aacdda1119d419ce886f9ba4b9401de2834bed\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"71068dfd2c15142503a57d7fd73f9f9670e3399a\", \"got_revision_cp\": \"refs/heads/master@{#849241}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"4d22b2c30f55e7edf6c2340d165e85fd386bd489\", \"got_v8_revision\": \"ef5b914f3d672592d9c56eb974df3ec2875f9239\", \"got_v8_revision_cp\": \"refs/heads/9.0.105@{#1}\", \"got_webrtc_revision\": \"989e6e7d22e281dde977c349355a8f1d76a8dff3\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33120}\", \"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\": \"71068dfd2c15142503a57d7fd73f9f9670e3399a\", \"swarm_hashes_refs/heads/master(at){#849241}_without_patch\": {\"absl_hardening_tests\": \"49ea8d83a8ea7982afc421ffbba81ed7e0281e50\", \"accessibility_unittests\": \"335f1253badc8e2a2690d0d187b99c71b9467251\", \"angle_unittests\": \"68eef97c97da6981aa9410ed4073f45967543ebd\", \"app_list_unittests\": \"210a6dad6aebad843cff45b14c85b5108a4897b4\", \"app_shell_unittests\": \"b4e949e36415356dbb6bfd2806b562bf96c880b7\", \"ash_unittests\": \"3e3df5a0a8a748286a5f77fbecd7e957fa3f7fcd\", \"aura_unittests\": \"1202ab324b9e40fa8c447896c6028da5b0db6c07\", \"base_unittests\": \"1927651e476b3e7488cebba27ecbb6ecd2e7d4d3\", \"base_util_unittests\": \"a941ec51a0128ca9cd7704880e99ccceb2827ccd\", \"blink_common_unittests\": \"4be3ae99bc75a83999bee03f57e4adf8e31528bd\", \"blink_fuzzer_unittests\": \"507d1af279e4babe313f74d0a1cc89cbc2bf5360\", \"blink_heap_unittests\": \"597415a88692491d900fb01a5c27dc5a8be854b7\", \"blink_platform_unittests\": \"4604025ec6e24b7ad42097ff29d60b7662d7cb6d\", \"blink_unittests\": \"80b801b99a38c6ca155cf2c360626b368ce9f084\", \"boringssl_crypto_tests\": \"b7d6cc1c2056d75ae0cae63f6365124d2be61809\", \"boringssl_ssl_tests\": \"b50a828c760ba7739138300783bde4bf8dd3ff31\", \"browser_tests\": \"271c26da073f48633134450985cd5ee1d8bee591\", \"capture_unittests\": \"c5dad37b84beab4263d741add90c7eee8b5f94e7\", \"cast_unittests\": \"82bdfeb36547d327f457720ef9ea83f135f46974\", \"cc_unittests\": \"40db32604ad4dc55eefc81e482398d812f83c409\", \"chrome_app_unittests\": \"f6a6f5ce8be96567c9469378062e5ca6026d3f40\", \"chromedriver_unittests\": \"edc3b499ea4d1be359d6dc178379f4c195ccf876\", \"chromeos_components_unittests\": \"4b37312257eb122f14bb01109c8e31e32a8e51f2\", \"chromeos_unittests\": \"8729a1ddf03097a16623f04583ca083c67a98950\", \"components_browsertests\": \"ce6b01332f52a91a51acf94f770726b524a2c110\", \"components_unittests\": \"72bca192e6b96e336546c3e11fbc6d6723dd85ce\", \"compositor_unittests\": \"92ac34fc41f4a50e1877c0942112a3323d116bfc\", \"content_browsertests\": \"91779108a86b22af7fe0c72e47071a435093a44b\", \"content_unittests\": \"4ddfcac6235fbd44bca0211cbbc5bbf2f97c70b3\", \"crashpad_tests\": \"95a938dd0b90517c5e698343f42257babd553d55\", \"crypto_unittests\": \"ec58b17768ad80649056ac383ee404c4c62a0493\", \"dbus_unittests\": \"530b0f405fa7c0f16f1caf197d22fdb4c69a897c\", \"device_unittests\": \"819eb584287821e1c06db86c09377fc4811b29d3\", \"display_unittests\": \"e0b77f2bcb5262ce06a96b2369043753862622af\", \"events_unittests\": \"674e6b1e678fcfdc1be5d035f51682a894cf693e\", \"exo_unittests\": \"8ff861d957e0f021db531c5f9b5f5d7c2095bba4\", \"extensions_browsertests\": \"44baa3caaea20e7729530bf1b8b9c6f0b074d14e\", \"extensions_unittests\": \"4636c608a7c3b53033339527be60ddbca39f46f2\", \"filesystem_service_unittests\": \"494051193865c270d2c2bb37df546faa6e3abe97\", \"gcm_unit_tests\": \"b598f67163ddaf5c3f2b5abef6aa6e7062c5b23c\", \"gfx_unittests\": \"07673a63b9f0e352c65ba0de3de13f171733dd6f\", \"gin_unittests\": \"9c8e4f8b481525b5aecb14edf093e808f1619dd3\", \"gl_unittests_ozone\": \"ae8b4346e66f1d700f06978dbbab9fd8f7b167f0\", \"google_apis_unittests\": \"c17c6ce7ba355053b49d975c83ee29497c28d007\", \"gpu_unittests\": \"a0346403c9ef0b7d9777fb60ce7e6a7440391c3d\", \"gwp_asan_unittests\": \"9eb0467b959e7927f142023e0ee6e67ad792a6d0\", \"interactive_ui_tests\": \"d928bc33e3a6babe44c74616e5567d4fb03cf2f2\", \"ipc_tests\": \"c3d7f87015fccbc243b34ec22760f309c741dcfe\", \"jingle_unittests\": \"6a5e36a7710cc1dc40c4ce7ef572df383c2d352a\", \"keyboard_unittests\": \"2debd79b0742f769736b2a2df93ab275f214ffe5\", \"latency_unittests\": \"4edc44573b69fe5ed064234dfcb2753b9cb0707c\", \"libjingle_xmpp_unittests\": \"b08b1289f6e63aa486f0a5495a95f790983cd04d\", \"liburlpattern_unittests\": \"e974a62401b4d112812962d32f34bb11a85ac32b\", \"media_blink_unittests\": \"445305b271e9db13186af1d3ccd31f4004d982e7\", \"media_unittests\": \"d7bc30d9f3bd1930f8baf65a301213f2e22dc59a\", \"message_center_unittests\": \"f77306bd6b7be8566613b0d01973545d3d935c78\", \"midi_unittests\": \"bd68b94296a584781e983fc52c1b082b06983a87\", \"mojo_core_unittests\": \"16a3e87af5e68c36c062ea0ddf9279db70a5715f\", \"mojo_unittests\": \"25cd3406d457d15b2911613c3917a5663f74983b\", \"nacl_helper_nonsfi_unittests\": \"f8cac38238b580106fd593f6ef27e3f32570cbb9\", \"nacl_loader_unittests\": \"1d286c32229be640c957fca377fe6dbd3723dbdf\", \"native_theme_unittests\": \"89f702fc843d4fb69069d81f0632c7b02f02e186\", \"net_unittests\": \"a947f258581bc3d97c7987996ba4cc4b21b7adbf\", \"ozone_gl_unittests\": \"e60b762d4c782179adcd34b59a1b2bd61d5a8aca\", \"ozone_unittests\": \"b9ae1828f29ebc03117eb3a36465f131c28cf1be\", \"ozone_x11_unittests\": \"bff0f5f9d04b6c95efac231e9cb4c1cdcb6ac30d\", \"pdf_unittests\": \"6d4d376d4007f6b3da170115fee2cc2df18a7e41\", \"perfetto_unittests\": \"b0e9e8149fae0cc98ab030d0be93847f2c9f7d19\", \"ppapi_unittests\": \"8d391375bb350b98a4e212142b6033a283a468b1\", \"printing_unittests\": \"a6a1ce6882f11e5cf06d1bdbc00e5739fbb15ecd\", \"remoting_unittests\": \"b201f4a794bb4a41abbd74acf1d03488452f0d02\", \"sandbox_linux_unittests\": \"e13544506dc449649472eab3cfca82ffb0390e72\", \"service_manager_unittests\": \"bd6a66dabac911bf8777f1587249873d0e7f6407\", \"services_unittests\": \"a52815ce37e870219638a921710804d3534f3865\", \"shell_dialogs_unittests\": \"0f48fe9a5240b491f6d0e51492bbe591b73f1f5a\", \"shell_encryption_unittests\": \"d51e077cd3df00e477c5087a7fd07044a868e54d\", \"skia_unittests\": \"324e1208a6a3ac8290cfb6e607a902309b5969e5\", \"snapshot_unittests\": \"a37d69d02700bce2c725f643878cd43f5de4aee4\", \"sql_unittests\": \"70c1a1c759b309ef692f852ad804cf44f7917a1f\", \"storage_unittests\": \"8a710026aaeefbc776e232d20288849489f07e96\", \"sync_integration_tests\": \"f13bc17b37d38e4a90a17b689cd08c1768380a13\", \"traffic_annotation_auditor_unittests\": \"f39dc3b1aa101b21b885f647a2f120d191498f16\", \"ui_base_unittests\": \"8ee74477a841c936c9ef2038eab1920ddab5a1da\", \"ui_chromeos_unittests\": \"1e2111999816f014e9f5cecac4a4683dd4cbc150\", \"ui_touch_selection_unittests\": \"1bba340a50df7657ba41f158c08c70dfcfcbe434\", \"unit_tests\": \"1aea4b36b0245d06ad74a98f44b8b0ea1a4b26c6\", \"url_unittests\": \"569fd9eab84152a3e3e2bb2970c61a678e5b4d12\", \"usage_time_limit_unittests\": \"3d1c2612f83edcb5b078a08f4e82fe956645247e\", \"views_unittests\": \"595fa8b7c717b873f20c6bf5e6aec44cadcaae7a\", \"viz_unittests\": \"74fe0dc99b70f63d87b206e146b5e1c19f996374\", \"wm_unittests\": \"280feaf2fdfcefb73d7721b0ed13df3f6696234e\", \"wtf_unittests\": \"e1d9d12a4cb12a592e049878ea52d6d1c2b4ced7\", \"zlib_unittests\": \"08952f54ab2cbe82ec16252356473b38ba92bbc0\"}}, \"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-central1-b-8-93-pui4\"], \"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\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612211426947128",
"status": "COMPLETED",
"status_changed_ts": "1612217452761402",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22434",
"builder:linux-chromeos-dbg",
"buildset:commit/git/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/71068dfd2c15142503a57d7fd73f9f9670e3399a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021897573165479408",
"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/8856467509920306864/+/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:51781b9b784c6710",
"user_agent:luci-scheduler"
],
"updated_ts": "1612217452766015",
"url": "https://ci.chromium.org/b/8856467509920306864",
"utcnow_ts": "1612217453407156"
}
}
[22:10:53.417] Invocation finished in 1h40m31.984407834s with status SUCCEEDED