[01:51:32.488] New invocation is queued and will start shortly
[01:51:33.657] Starting the invocation (attempt 1)
[01:51:33.702] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:51:33.702] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:51:33.702] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018525278269089552",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018525278269089552",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master"
]
}
[01:51:34.756] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615427493832181",
"id": "8853095216185851952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615427494543897",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22944",
"builder:linux-chromeos-dbg",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018525278269089552",
"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/8853095216185851952/+/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": "1615427494544000",
"url": "https://ci.chromium.org/b/8853095216185851952",
"utcnow_ts": "1615427494742318"
}
}
[01:51:34.756] Task URL: https://ci.chromium.org/b/8853095216185851952
[01:51:34.756] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:2:0) after 1m0s
[01:52:08.732] Received PubSub notification, asking Buildbucket for the build status
[01:52:08.804] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:34.828] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:2:0)
[01:52:34.828] Timer tick, asking Buildbucket for the build status
[01:52:34.901] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:34.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:4:0) after 1m0s
[01:53:34.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:4:0)
[01:53:34.934] Timer tick, asking Buildbucket for the build status
[01:53:35.274] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:35.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:5:0) after 1m0s
[01:54:35.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:5:0)
[01:54:35.334] Timer tick, asking Buildbucket for the build status
[01:54:35.406] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:35.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:6:0) after 1m0s
[01:55:35.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:6:0)
[01:55:35.427] Timer tick, asking Buildbucket for the build status
[01:55:35.711] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:35.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:7:0) after 1m0s
[01:56:35.755] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:7:0)
[01:56:35.755] Timer tick, asking Buildbucket for the build status
[01:56:35.853] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:35.853] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:8:0) after 1m0s
[01:57:35.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:8:0)
[01:57:35.838] Timer tick, asking Buildbucket for the build status
[01:57:35.912] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:35.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:9:0) after 1m0s
[01:58:35.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:9:0)
[01:58:35.950] Timer tick, asking Buildbucket for the build status
[01:58:36.027] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:36.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:10:0) after 1m0s
[01:59:36.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:10:0)
[01:59:36.070] Timer tick, asking Buildbucket for the build status
[01:59:36.148] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:36.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:11:0) after 1m0s
[02:00:36.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:11:0)
[02:00:36.148] Timer tick, asking Buildbucket for the build status
[02:00:36.295] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:36.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:12:0) after 1m0s
[02:01:36.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:12:0)
[02:01:36.329] Timer tick, asking Buildbucket for the build status
[02:01:36.702] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:36.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:13:0) after 1m0s
[02:02:36.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:13:0)
[02:02:36.781] Timer tick, asking Buildbucket for the build status
[02:02:36.914] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:36.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:14:0) after 1m0s
[02:03:36.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:14:0)
[02:03:36.931] Timer tick, asking Buildbucket for the build status
[02:03:36.997] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:36.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:15:0) after 1m0s
[02:04:37.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:15:0)
[02:04:37.060] Timer tick, asking Buildbucket for the build status
[02:04:37.159] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:37.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:16:0) after 1m0s
[02:05:37.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:16:0)
[02:05:37.155] Timer tick, asking Buildbucket for the build status
[02:05:37.241] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:37.241] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:17:0) after 1m0s
[02:06:37.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:17:0)
[02:06:37.282] Timer tick, asking Buildbucket for the build status
[02:06:37.374] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:37.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:18:0) after 1m0s
[02:07:37.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:18:0)
[02:07:37.461] Timer tick, asking Buildbucket for the build status
[02:07:37.552] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:37.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:19:0) after 1m0s
[02:08:37.541] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:19:0)
[02:08:37.541] Timer tick, asking Buildbucket for the build status
[02:08:37.650] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:37.650] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:20:0) after 1m0s
[02:09:37.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:20:0)
[02:09:37.748] Timer tick, asking Buildbucket for the build status
[02:09:38.061] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:38.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:21:0) after 1m0s
[02:10:38.071] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:21:0)
[02:10:38.071] Timer tick, asking Buildbucket for the build status
[02:10:38.155] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:38.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:22:0) after 1m0s
[02:11:38.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:22:0)
[02:11:38.199] Timer tick, asking Buildbucket for the build status
[02:11:38.280] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:38.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:23:0) after 1m0s
[02:12:38.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:23:0)
[02:12:38.274] Timer tick, asking Buildbucket for the build status
[02:12:38.359] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:38.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:24:0) after 1m0s
[02:13:38.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:24:0)
[02:13:38.468] Timer tick, asking Buildbucket for the build status
[02:13:38.532] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:38.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:25:0) after 1m0s
[02:14:38.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:25:0)
[02:14:38.562] Timer tick, asking Buildbucket for the build status
[02:14:38.641] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:38.641] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:26:0) after 1m0s
[02:15:38.719] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:26:0)
[02:15:38.719] Timer tick, asking Buildbucket for the build status
[02:15:38.789] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:38.789] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:27:0) after 1m0s
[02:16:38.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:27:0)
[02:16:38.839] Timer tick, asking Buildbucket for the build status
[02:16:39.322] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:39.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:28:0) after 1m0s
[02:17:39.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:28:0)
[02:17:39.303] Timer tick, asking Buildbucket for the build status
[02:17:39.382] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:39.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:29:0) after 1m0s
[02:18:39.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:29:0)
[02:18:39.409] Timer tick, asking Buildbucket for the build status
[02:18:39.473] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:39.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:30:0) after 1m0s
[02:19:39.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:30:0)
[02:19:39.519] Timer tick, asking Buildbucket for the build status
[02:19:39.621] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:39.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:31:0) after 1m0s
[02:20:39.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:31:0)
[02:20:39.637] Timer tick, asking Buildbucket for the build status
[02:20:40.072] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:40.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:32:0) after 1m0s
[02:21:40.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:32:0)
[02:21:40.112] Timer tick, asking Buildbucket for the build status
[02:21:40.301] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:40.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:33:0) after 1m0s
[02:22:40.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:33:0)
[02:22:40.347] Timer tick, asking Buildbucket for the build status
[02:22:40.425] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:40.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:34:0) after 1m0s
[02:23:40.465] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:34:0)
[02:23:40.465] Timer tick, asking Buildbucket for the build status
[02:23:40.533] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:40.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:35:0) after 1m0s
[02:24:40.630] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:35:0)
[02:24:40.630] Timer tick, asking Buildbucket for the build status
[02:24:40.717] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:40.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:36:0) after 1m0s
[02:25:40.810] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:36:0)
[02:25:40.810] Timer tick, asking Buildbucket for the build status
[02:25:40.923] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:40.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:37:0) after 1m0s
[02:26:40.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:37:0)
[02:26:40.949] Timer tick, asking Buildbucket for the build status
[02:26:41.037] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:41.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:38:0) after 1m0s
[02:27:41.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:38:0)
[02:27:41.162] Timer tick, asking Buildbucket for the build status
[02:27:41.411] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:41.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:39:0) after 1m0s
[02:28:41.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:39:0)
[02:28:41.455] Timer tick, asking Buildbucket for the build status
[02:28:41.841] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:41.841] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:40:0) after 1m0s
[02:29:41.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:40:0)
[02:29:41.853] Timer tick, asking Buildbucket for the build status
[02:29:41.925] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:41.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:41:0) after 1m0s
[02:30:42.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:41:0)
[02:30:42.031] Timer tick, asking Buildbucket for the build status
[02:30:42.109] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:42.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:42:0) after 1m0s
[02:31:42.134] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:42:0)
[02:31:42.134] Timer tick, asking Buildbucket for the build status
[02:31:42.215] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:42.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:43:0) after 1m0s
[02:32:42.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:43:0)
[02:32:42.344] Timer tick, asking Buildbucket for the build status
[02:32:42.427] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:42.427] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:44:0) after 1m0s
[02:33:42.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:44:0)
[02:33:42.526] Timer tick, asking Buildbucket for the build status
[02:33:42.627] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:42.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:45:0) after 1m0s
[02:34:42.765] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:45:0)
[02:34:42.765] Timer tick, asking Buildbucket for the build status
[02:34:42.874] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:42.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:46:0) after 1m0s
[02:35:42.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:46:0)
[02:35:42.982] Timer tick, asking Buildbucket for the build status
[02:35:43.088] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:43.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:47:0) after 1m0s
[02:36:43.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:47:0)
[02:36:43.128] Timer tick, asking Buildbucket for the build status
[02:36:43.445] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:43.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:48:0) after 1m0s
[02:37:43.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:48:0)
[02:37:43.432] Timer tick, asking Buildbucket for the build status
[02:37:43.726] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:43.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:49:0) after 1m0s
[02:38:43.775] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:49:0)
[02:38:43.775] Timer tick, asking Buildbucket for the build status
[02:38:44.040] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:44.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:50:0) after 1m0s
[02:39:44.129] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:50:0)
[02:39:44.129] Timer tick, asking Buildbucket for the build status
[02:39:44.237] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:44.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:51:0) after 1m0s
[02:40:44.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:51:0)
[02:40:44.320] Timer tick, asking Buildbucket for the build status
[02:40:44.421] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:44.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:52:0) after 1m0s
[02:41:44.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:52:0)
[02:41:44.485] Timer tick, asking Buildbucket for the build status
[02:41:44.636] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:44.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:53:0) after 1m0s
[02:42:44.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:53:0)
[02:42:44.672] Timer tick, asking Buildbucket for the build status
[02:42:44.788] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:44.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:54:0) after 1m0s
[02:43:44.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:54:0)
[02:43:44.900] Timer tick, asking Buildbucket for the build status
[02:43:44.997] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:44.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:55:0) after 1m0s
[02:44:45.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:55:0)
[02:44:45.049] Timer tick, asking Buildbucket for the build status
[02:44:45.159] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:56:0) after 1m0s
[02:45:45.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:56:0)
[02:45:45.421] Timer tick, asking Buildbucket for the build status
[02:45:45.569] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:45.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:57:0) after 1m0s
[02:46:45.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:57:0)
[02:46:45.651] Timer tick, asking Buildbucket for the build status
[02:46:45.767] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:45.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:58:0) after 1m0s
[02:47:45.951] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:58:0)
[02:47:45.951] Timer tick, asking Buildbucket for the build status
[02:47:46.067] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:46.067] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:59:0) after 1m0s
[02:48:46.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:59:0)
[02:48:46.243] Timer tick, asking Buildbucket for the build status
[02:48:46.363] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:46.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:60:0) after 1m0s
[02:49:46.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:60:0)
[02:49:46.767] Timer tick, asking Buildbucket for the build status
[02:49:46.900] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:46.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:61:0) after 1m0s
[02:50:47.137] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:61:0)
[02:50:47.137] Timer tick, asking Buildbucket for the build status
[02:50:47.230] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:47.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:62:0) after 1m0s
[02:51:47.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:62:0)
[02:51:47.351] Timer tick, asking Buildbucket for the build status
[02:51:47.474] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:47.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:63:0) after 1m0s
[02:52:47.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:63:0)
[02:52:47.588] Timer tick, asking Buildbucket for the build status
[02:52:47.691] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:47.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:64:0) after 1m0s
[02:53:47.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:64:0)
[02:53:47.948] Timer tick, asking Buildbucket for the build status
[02:53:48.073] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:48.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:65:0) after 1m0s
[02:54:48.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:65:0)
[02:54:48.170] Timer tick, asking Buildbucket for the build status
[02:54:48.368] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:48.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:66:0) after 1m0s
[02:55:48.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:66:0)
[02:55:48.428] Timer tick, asking Buildbucket for the build status
[02:55:48.635] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:48.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:67:0) after 1m0s
[02:56:48.663] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:67:0)
[02:56:48.663] Timer tick, asking Buildbucket for the build status
[02:56:49.337] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:49.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:68:0) after 1m0s
[02:57:49.360] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:68:0)
[02:57:49.360] Timer tick, asking Buildbucket for the build status
[02:57:49.442] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:49.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:69:0) after 1m0s
[02:58:49.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:69:0)
[02:58:49.466] Timer tick, asking Buildbucket for the build status
[02:58:49.550] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:49.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:70:0) after 1m0s
[02:59:49.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:70:0)
[02:59:49.555] Timer tick, asking Buildbucket for the build status
[02:59:49.627] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:49.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:71:0) after 1m0s
[03:00:49.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:71:0)
[03:00:49.691] Timer tick, asking Buildbucket for the build status
[03:00:49.769] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:49.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:72:0) after 1m0s
[03:01:49.794] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:72:0)
[03:01:49.794] Timer tick, asking Buildbucket for the build status
[03:01:50.138] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:50.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:73:0) after 1m0s
[03:02:50.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:73:0)
[03:02:50.192] Timer tick, asking Buildbucket for the build status
[03:02:50.286] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:50.286] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:74:0) after 1m0s
[03:03:50.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:74:0)
[03:03:50.288] Timer tick, asking Buildbucket for the build status
[03:03:50.907] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:50.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:75:0) after 1m0s
[03:04:51.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:75:0)
[03:04:51.034] Timer tick, asking Buildbucket for the build status
[03:04:51.152] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:51.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:76:0) after 1m0s
[03:05:51.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:76:0)
[03:05:51.171] Timer tick, asking Buildbucket for the build status
[03:05:51.266] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:51.266] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:77:0) after 1m0s
[03:06:51.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:77:0)
[03:06:51.265] Timer tick, asking Buildbucket for the build status
[03:06:51.379] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:51.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:78:0) after 1m0s
[03:07:51.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:78:0)
[03:07:51.427] Timer tick, asking Buildbucket for the build status
[03:07:51.508] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:51.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:79:0) after 1m0s
[03:08:51.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:79:0)
[03:08:51.566] Timer tick, asking Buildbucket for the build status
[03:08:51.907] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:51.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:80:0) after 1m0s
[03:09:52.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:80:0)
[03:09:52.003] Timer tick, asking Buildbucket for the build status
[03:09:52.086] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:52.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:81:0) after 1m0s
[03:10:52.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:81:0)
[03:10:52.126] Timer tick, asking Buildbucket for the build status
[03:10:52.214] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:52.214] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:82:0) after 1m0s
[03:11:52.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:82:0)
[03:11:52.260] Timer tick, asking Buildbucket for the build status
[03:11:52.496] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:52.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:83:0) after 1m0s
[03:12:52.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:83:0)
[03:12:52.489] Timer tick, asking Buildbucket for the build status
[03:12:52.639] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:52.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:84:0) after 1m0s
[03:13:52.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:84:0)
[03:13:52.645] Timer tick, asking Buildbucket for the build status
[03:13:52.724] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:52.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:85:0) after 1m0s
[03:14:52.771] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:85:0)
[03:14:52.771] Timer tick, asking Buildbucket for the build status
[03:14:52.949] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:52.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:86:0) after 1m0s
[03:15:52.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:86:0)
[03:15:52.992] Timer tick, asking Buildbucket for the build status
[03:15:53.087] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:53.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:87:0) after 1m0s
[03:16:53.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:87:0)
[03:16:53.162] Timer tick, asking Buildbucket for the build status
[03:16:53.272] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:53.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:88:0) after 1m0s
[03:17:53.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:88:0)
[03:17:53.316] Timer tick, asking Buildbucket for the build status
[03:17:53.392] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:53.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:89:0) after 1m0s
[03:18:53.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:89:0)
[03:18:53.596] Timer tick, asking Buildbucket for the build status
[03:18:53.681] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:53.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:90:0) after 1m0s
[03:19:53.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:90:0)
[03:19:53.919] Timer tick, asking Buildbucket for the build status
[03:19:53.997] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:53.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:91:0) after 1m0s
[03:20:54.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:91:0)
[03:20:54.069] Timer tick, asking Buildbucket for the build status
[03:20:54.256] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:54.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:92:0) after 1m0s
[03:21:54.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:92:0)
[03:21:54.362] Timer tick, asking Buildbucket for the build status
[03:21:54.460] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:54.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:93:0) after 1m0s
[03:22:54.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:93:0)
[03:22:54.441] Timer tick, asking Buildbucket for the build status
[03:22:54.793] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:54.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:94:0) after 1m0s
[03:23:54.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:94:0)
[03:23:54.921] Timer tick, asking Buildbucket for the build status
[03:23:55.157] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:55.157] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:95:0) after 1m0s
[03:24:55.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:95:0)
[03:24:55.206] Timer tick, asking Buildbucket for the build status
[03:24:55.294] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:55.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:96:0) after 1m0s
[03:25:55.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:96:0)
[03:25:55.330] Timer tick, asking Buildbucket for the build status
[03:25:55.654] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:55.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:97:0) after 1m0s
[03:26:55.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:97:0)
[03:26:55.686] Timer tick, asking Buildbucket for the build status
[03:26:55.916] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:55.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:98:0) after 1m0s
[03:27:56.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:98:0)
[03:27:56.015] Timer tick, asking Buildbucket for the build status
[03:27:56.095] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:56.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:99:0) after 1m0s
[03:28:56.120] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:99:0)
[03:28:56.120] Timer tick, asking Buildbucket for the build status
[03:28:56.299] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:56.299] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:100:0) after 1m0s
[03:29:56.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:100:0)
[03:29:56.296] Timer tick, asking Buildbucket for the build status
[03:29:56.378] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:56.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:101:0) after 1m0s
[03:30:56.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:101:0)
[03:30:56.421] Timer tick, asking Buildbucket for the build status
[03:30:56.519] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:56.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:102:0) after 1m0s
[03:31:56.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:102:0)
[03:31:56.566] Timer tick, asking Buildbucket for the build status
[03:31:56.849] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:56.849] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:103:0) after 1m0s
[03:32:56.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:103:0)
[03:32:56.897] Timer tick, asking Buildbucket for the build status
[03:32:56.986] Build 8853095216185851952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:56.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018525278269089552:104:0) after 1m0s
[03:33:24.528] Received PubSub notification, asking Buildbucket for the build status
[03:33:24.869] Build 8853095216185851952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:33:24.869] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615433602815363",
"created_by": "project:chromium",
"created_ts": "1615427493832181",
"id": "8853095216185851952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\"}}",
"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\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"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-44-4rk7\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22944, \"got_angle_revision\": \"44b9579cf7b8d35cac13f9e2d70c57791ddfd0e2\", \"got_dawn_revision\": \"6d4617a2d28d8d3d4aa946abdbabb368d025b6b7\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"got_revision_cp\": \"refs/heads/master@{#861802}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a2fe8e1b2111e69d8846991f9d9bcc5c49505d1c\", \"got_v8_revision\": \"380d3d23acddd8b6eb5521fbf5cf30b9ff8ac301\", \"got_v8_revision_cp\": \"refs/heads/9.1.95@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"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\": \"21c857e5f67cbb80f4c91cf50e82d1c719817de0\", \"swarm_hashes_refs/heads/master(at){#861802}_without_patch\": {\"absl_hardening_tests\": \"a283f6fee0c0b63476a1483be675c68d12e7360f\", \"accessibility_unittests\": \"0e2948d8f0aaf5c27b96c0ca701834a3e44663cd\", \"angle_unittests\": \"912d025fe0b78257195f35801cf023b6f8a0e10b\", \"app_list_unittests\": \"bc0dc7db6d51168796b03045feb80bd155d2afae\", \"app_shell_unittests\": \"4964761db9ed6d562028c8ce419b22f48833ad9c\", \"ash_unittests\": \"76473ffc66a7b7b37cc11ea08382c8c7f77eb35a\", \"aura_unittests\": \"f59abff7c5ba72f86f225b4a0fa24f06240bc3ef\", \"base_unittests\": \"3a0f8383ae43703f83746606202fd9420a7fff9a\", \"base_util_unittests\": \"83a2f1a1873ff0c9753c0e869cbfad87c79909d0\", \"blink_common_unittests\": \"fb5941b88a8e8112d9bc7d96ee7a546df53d2a82\", \"blink_fuzzer_unittests\": \"25db35836b58f261329dca61df8ec45529ffa3c7\", \"blink_heap_unittests\": \"e86af0306d8a19e071151124792f1d6bd640562f\", \"blink_platform_unittests\": \"91f5c54c20cf689ac18d5ed714632fd8017df379\", \"blink_unittests\": \"cea169fbbab56420a36b6ec9bd44bc4f74d55d56\", \"boringssl_crypto_tests\": \"3382d5def3ca02acd17523128d066cd80246db5d\", \"boringssl_ssl_tests\": \"e6f0f931c159e1f4363bd4ab5daa22417dc69ad4\", \"browser_tests\": \"520368e812e29098d4d6bebe71b4159bb6eb6921\", \"capture_unittests\": \"6ef9f27fa0096f2b52c39b809bd717015c05a7b3\", \"cast_unittests\": \"71affd28c969d46072f4685efa15491eb434a443\", \"cc_unittests\": \"8155b32a384d82adddf803d9b6d3c474674a28d5\", \"chrome_app_unittests\": \"e91700bba1421804109b4183a4786ae0a6fe03f8\", \"chromedriver_unittests\": \"6a0f3ce81721c451e722c6f9b6071ec265b6f146\", \"chromeos_components_unittests\": \"9380c47cce6ffeaa2a88e07648c3d143bbe483a6\", \"chromeos_unittests\": \"bcc0b5e089f2f5393dcf3f421bace3987cc52d11\", \"color_unittests\": \"f4f702112dc5c962f479f4d7e4cc23b19b82d5ac\", \"components_browsertests\": \"9d3ca9961561213deb7ac9608f5a44879a3cc711\", \"components_unittests\": \"c484d7eca95e6e7fa25e83021cf13a54c20ca741\", \"compositor_unittests\": \"768e853f3289a655bca419437d98cddf8fa6ddf2\", \"content_browsertests\": \"a94d46f4d6dc8538c7d9f1bacce117f6a09b6141\", \"content_unittests\": \"6cb43bc1453ba7155de061303fb205c9f0483e83\", \"crashpad_tests\": \"f417e6a9e74d347363563e49f91b621bfb2f3ef0\", \"crypto_unittests\": \"82ff373c2d215c4986d89988eda2dcfffb3d17ed\", \"dbus_unittests\": \"c5e473ae06bff50d671e2a5e03f1c85c9b724747\", \"device_unittests\": \"5bffcd4eefc65a4d167b569779bdb3b2c71f403d\", \"display_unittests\": \"0817177a0a8448b3fa34d2ced54bd2df56d34aa7\", \"events_unittests\": \"4a5dbd172faf39ba485b8b866dc192f71f2d9d78\", \"exo_unittests\": \"db4e941f93a62f1b7607012836f2f7123fe38f0b\", \"extensions_browsertests\": \"d8595e1454c62034e1d6478d452e068c482e3e07\", \"extensions_unittests\": \"5fcf7a90dfc6f491508ca04caaac8a31378e11ac\", \"filesystem_service_unittests\": \"e93cf99c4cff6e17d5157d5183b867414af3ea23\", \"gcm_unit_tests\": \"0c10f87b948785a31e3b52c3a60f58fd5b535d4f\", \"gfx_unittests\": \"c1b484c3b614a926805c67f16bc7499a5a4ae021\", \"gin_unittests\": \"b1f5e061238cb81e5e23b8f78002b31880658a64\", \"gl_unittests_ozone\": \"15ac0d10c5c631fd7e42dcfcedef9100baa1e544\", \"google_apis_unittests\": \"4faa3f7fb9fb806306c5b79d4620f903f9d7cebe\", \"gpu_unittests\": \"649b70afd8315fa5be7bb0fb3d55099da6817edb\", \"gwp_asan_unittests\": \"d3dc0817fd2cf9d32298099377515c7b3b78b41f\", \"interactive_ui_tests\": \"12a7cd22aa4352e2f971a2cbc925a71e978fdcd5\", \"ipc_tests\": \"6cceb8d0f297bce6c92b8240c55b1d7365f982f9\", \"jingle_unittests\": \"420467bcee4065986a935a98198314bf153dec3e\", \"keyboard_unittests\": \"76d2c188d43d995703d772e4eb8702ebe0165429\", \"latency_unittests\": \"dd76b8615db6c8c7f4061083ccab0e7bcfd430e8\", \"libjingle_xmpp_unittests\": \"0c08f382ed29d9f5a8fa1fe51d9b4279136d38cd\", \"liburlpattern_unittests\": \"890816ae51a5a4a5a12b1046b887307274066951\", \"media_blink_unittests\": \"5cf8a5a98522d89b7631bd02b0971df968a5316c\", \"media_unittests\": \"057c9b9dc8604bdc1f3714829dfc12e499bf8923\", \"message_center_unittests\": \"633929a75c082f225b2df3ebf2497ea3128253d2\", \"midi_unittests\": \"3a9b80c3ca5b5571fa482474bef4f08bb94924cf\", \"mojo_core_unittests\": \"3474a5aff61ad43f24aec6b33b98586ffcb65132\", \"mojo_unittests\": \"5aebe8f9deffc5c0715504940393cc2be0e4b214\", \"nacl_helper_nonsfi_unittests\": \"615d5b274f4066fc77a7e8e12ea0d4d33abe7e87\", \"nacl_loader_unittests\": \"6831e25c6084fa4879e6c10adb950d0a2d3da3a4\", \"native_theme_unittests\": \"2aae4b64644cbb444a6db12d670a9bf8763c1bc9\", \"net_unittests\": \"46fdc0dbd0f251dcde9b5987b66d8d2a90bfe44b\", \"ozone_gl_unittests\": \"a6a28500b56c8a76d526503935ffa1d9ef3626fe\", \"ozone_unittests\": \"e4d2c7a26e7f06f6bc632a1d37c1ce8ae58b2e2a\", \"ozone_x11_unittests\": \"1a762c61d47819ff5fa899bf5ce1f12be891795d\", \"pdf_unittests\": \"27b5d275d60685a3e6cfe250eac001c93c911ed5\", \"perfetto_unittests\": \"e25bdc20a9dd3e33acb4ed0197a055d07fe67c90\", \"ppapi_unittests\": \"650764b5d4a9a9c4269849dcef8d4ce73f14a817\", \"printing_unittests\": \"ad3d866b6bbbb5dbea02ab989b09a853bb38bdba\", \"remoting_unittests\": \"acd23325399187085d4478bf340f170a08dc5a42\", \"sandbox_linux_unittests\": \"f9a7757a3c8ffd58a72b8c8fd23021b66bdccb89\", \"service_manager_unittests\": \"28b37d4ee632db8b061b958002d44515b99964ff\", \"services_unittests\": \"1af829741e55c8ffcda84751d013d994641ce4b5\", \"shell_dialogs_unittests\": \"560aacf30dca3df6f58431ac73eecf852dfbda25\", \"shell_encryption_unittests\": \"1465f597e9413e78e17119d048788294511a1201\", \"skia_unittests\": \"375dc7f0c786a54792cf1e02708bb63d75f9bc4b\", \"snapshot_unittests\": \"d29092ff5f75a39e99ef1f594a550d85a76646ad\", \"sql_unittests\": \"7ada2fdcc8f8a2135c842d843a59122d16771d43\", \"storage_unittests\": \"d4dd8281ee35204870482532ce8637bd2ec93b17\", \"sync_integration_tests\": \"7d16c40739fd37c7b93d894a65a0defcb3ae0df0\", \"traffic_annotation_auditor_unittests\": \"ea99c49756135a23882d233d46eb7ca233fb3645\", \"ui_base_unittests\": \"73cb234069f77fbba7d14d2c50a335f64115c717\", \"ui_chromeos_unittests\": \"6707b26443cb33ffbe13796fbfe0d2f1c7fe42bf\", \"ui_touch_selection_unittests\": \"d6914c5a51529fd4006e070755aee7113fd5e052\", \"unit_tests\": \"af8c4f5689bdeea9b8e9f7ef7b84587a6d126781\", \"url_unittests\": \"b976e8ac86e19da76ff4a3de4a11c0dfa9ca0a5e\", \"usage_time_limit_unittests\": \"695512e328fc1600f54cf3318586e131268e7d7d\", \"views_unittests\": \"2720cafd83d15d173b4ad86f72ad69ca7fa2c002\", \"viz_unittests\": \"31a1441bedd58b82a99ca89475a1d0f2baff1b60\", \"wayland_client_tests\": \"9035f6c8af64f64dd909290d97e6cb64dc9883a0\", \"wm_unittests\": \"ac34c50e28678c93afb398a5cb2fae21d697e09c\", \"wtf_unittests\": \"393e81d279f2a9f6d3d0df71cdeba741fea40d02\", \"zlib_unittests\": \"4aacea4c9bbadc3784a934adfb28a858b13ef4fa\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_6c78a7f8d33b40824ce59948f4a03b9b1d7e446f2adcc16b16c0c54004d8c305_v2\", \"builder_8083860191ac1707bdac6310382d6ca226876fc8f88202f45d8d07453f74f5a4_v2\", \"builder_9ab1612fdb00db29a8d60b17a842600a8e29ecb37944be685dafbc3ddd01329a_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_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-44-4rk7\"], \"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\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615427528207209",
"status": "COMPLETED",
"status_changed_ts": "1615433603467591",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22944",
"builder:linux-chromeos-dbg",
"buildset:commit/git/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21c857e5f67cbb80f4c91cf50e82d1c719817de0",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018525278269089552",
"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/8853095216185851952/+/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:5237ccec3fc0c210",
"user_agent:luci-scheduler"
],
"updated_ts": "1615433603512452",
"url": "https://ci.chromium.org/b/8853095216185851952",
"utcnow_ts": "1615433604851331"
}
}
[03:33:24.869] Invocation finished in 1h41m52.406660307s with status SUCCEEDED