[23:09:10.547] New invocation is queued and will start shortly
[23:09:11.687] Starting the invocation (attempt 1)
[23:09:11.724] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:09:11.724] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:09:11.725] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019350866121396160",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"a8c353ed9c51ca1240f2525f496e3383cb5288c5\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019350866121396160",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"gitiles_ref:refs/heads/master"
]
}
[23:09:12.445] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614640151792520",
"id": "8853920804152761456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a8c353ed9c51ca1240f2525f496e3383cb5288c5\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614640152295570",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22823",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019350866121396160",
"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/8853920804152761456/+/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": "1614640152295743",
"url": "https://ci.chromium.org/b/8853920804152761456",
"utcnow_ts": "1614640152437386"
}
}
[23:09:12.445] Task URL: https://ci.chromium.org/b/8853920804152761456
[23:09:12.445] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:2:0) after 1m0s
[23:10:12.571] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:2:0)
[23:10:12.571] Timer tick, asking Buildbucket for the build status
[23:10:12.673] Build 8853920804152761456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:10:12.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:3:0) after 1m0s
[23:11:12.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:3:0)
[23:11:12.703] Timer tick, asking Buildbucket for the build status
[23:11:12.874] Build 8853920804152761456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:11:12.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:4:0) after 1m0s
[23:12:12.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:4:0)
[23:12:12.934] Timer tick, asking Buildbucket for the build status
[23:12:13.021] Build 8853920804152761456: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:12:13.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:5:0) after 1m0s
[23:12:14.028] Received PubSub notification, asking Buildbucket for the build status
[23:12:14.124] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:13.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:5:0)
[23:13:13.264] Timer tick, asking Buildbucket for the build status
[23:13:13.345] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:13.345] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:7:0) after 1m0s
[23:14:13.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:7:0)
[23:14:13.631] Timer tick, asking Buildbucket for the build status
[23:14:14.192] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:14.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:8:0) after 1m0s
[23:15:14.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:8:0)
[23:15:14.280] Timer tick, asking Buildbucket for the build status
[23:15:14.372] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:14.372] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:9:0) after 1m0s
[23:16:14.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:9:0)
[23:16:14.419] Timer tick, asking Buildbucket for the build status
[23:16:15.030] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:15.030] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:10:0) after 1m0s
[23:17:15.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:10:0)
[23:17:15.401] Timer tick, asking Buildbucket for the build status
[23:17:15.755] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:15.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:11:0) after 1m0s
[23:18:15.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:11:0)
[23:18:15.774] Timer tick, asking Buildbucket for the build status
[23:18:16.921] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:16.921] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:12:0) after 1m0s
[23:19:17.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:12:0)
[23:19:17.060] Timer tick, asking Buildbucket for the build status
[23:19:17.166] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:17.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:13:0) after 1m0s
[23:20:17.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:13:0)
[23:20:17.311] Timer tick, asking Buildbucket for the build status
[23:20:17.387] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:17.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:14:0) after 1m0s
[23:21:17.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:14:0)
[23:21:17.471] Timer tick, asking Buildbucket for the build status
[23:21:17.584] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:17.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:15:0) after 1m0s
[23:22:17.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:15:0)
[23:22:17.642] Timer tick, asking Buildbucket for the build status
[23:22:17.721] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:17.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:16:0) after 1m0s
[23:23:17.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:16:0)
[23:23:17.881] Timer tick, asking Buildbucket for the build status
[23:23:18.264] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:18.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:17:0) after 1m0s
[23:24:18.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:17:0)
[23:24:18.343] Timer tick, asking Buildbucket for the build status
[23:24:18.443] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:18.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:18:0) after 1m0s
[23:25:18.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:18:0)
[23:25:18.464] Timer tick, asking Buildbucket for the build status
[23:25:18.637] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:18.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:19:0) after 1m0s
[23:26:18.674] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:19:0)
[23:26:18.674] Timer tick, asking Buildbucket for the build status
[23:26:18.873] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:18.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:20:0) after 1m0s
[23:27:18.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:20:0)
[23:27:18.931] Timer tick, asking Buildbucket for the build status
[23:27:18.998] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:18.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:21:0) after 1m0s
[23:28:19.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:21:0)
[23:28:19.059] Timer tick, asking Buildbucket for the build status
[23:28:19.135] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:19.135] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:22:0) after 1m0s
[23:29:19.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:22:0)
[23:29:19.156] Timer tick, asking Buildbucket for the build status
[23:29:20.017] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:20.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:23:0) after 1m0s
[23:30:20.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:23:0)
[23:30:20.074] Timer tick, asking Buildbucket for the build status
[23:30:21.807] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:21.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:24:0) after 1m0s
[23:31:21.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:24:0)
[23:31:21.868] Timer tick, asking Buildbucket for the build status
[23:31:21.987] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:21.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:25:0) after 1m0s
[23:32:22.068] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:25:0)
[23:32:22.068] Timer tick, asking Buildbucket for the build status
[23:32:22.236] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:22.236] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:26:0) after 1m0s
[23:33:22.293] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:26:0)
[23:33:22.293] Timer tick, asking Buildbucket for the build status
[23:33:22.420] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:27:0) after 1m0s
[23:34:22.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:27:0)
[23:34:22.475] Timer tick, asking Buildbucket for the build status
[23:34:22.555] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:22.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:28:0) after 1m0s
[23:35:22.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:28:0)
[23:35:22.606] Timer tick, asking Buildbucket for the build status
[23:35:22.750] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:22.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:29:0) after 1m0s
[23:36:22.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:29:0)
[23:36:22.767] Timer tick, asking Buildbucket for the build status
[23:36:22.916] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:22.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:30:0) after 1m0s
[23:37:22.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:30:0)
[23:37:22.983] Timer tick, asking Buildbucket for the build status
[23:37:23.136] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:31:0) after 1m0s
[23:38:23.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:31:0)
[23:38:23.178] Timer tick, asking Buildbucket for the build status
[23:38:23.308] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:32:0) after 1m0s
[23:39:23.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:32:0)
[23:39:23.285] Timer tick, asking Buildbucket for the build status
[23:39:23.366] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:23.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:33:0) after 1m0s
[23:40:23.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:33:0)
[23:40:23.405] Timer tick, asking Buildbucket for the build status
[23:40:23.479] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:23.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:34:0) after 1m0s
[23:41:23.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:34:0)
[23:41:23.507] Timer tick, asking Buildbucket for the build status
[23:41:23.601] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:23.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:35:0) after 1m0s
[23:42:23.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:35:0)
[23:42:23.681] Timer tick, asking Buildbucket for the build status
[23:42:23.908] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:23.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:36:0) after 1m0s
[23:43:23.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:36:0)
[23:43:23.887] Timer tick, asking Buildbucket for the build status
[23:43:24.361] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:24.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:37:0) after 1m0s
[23:44:24.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:37:0)
[23:44:24.371] Timer tick, asking Buildbucket for the build status
[23:44:27.272] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:27.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:38:0) after 1m0s
[23:45:27.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:38:0)
[23:45:27.373] Timer tick, asking Buildbucket for the build status
[23:45:27.526] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:27.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:39:0) after 1m0s
[23:46:27.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:39:0)
[23:46:27.666] Timer tick, asking Buildbucket for the build status
[23:46:27.774] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:27.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:40:0) after 1m0s
[23:47:27.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:40:0)
[23:47:27.793] Timer tick, asking Buildbucket for the build status
[23:47:27.904] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:27.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:41:0) after 1m0s
[23:48:27.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:41:0)
[23:48:27.960] Timer tick, asking Buildbucket for the build status
[23:48:28.063] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:28.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:42:0) after 1m0s
[23:49:28.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:42:0)
[23:49:28.157] Timer tick, asking Buildbucket for the build status
[23:49:28.247] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:28.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:43:0) after 1m0s
[23:50:28.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:43:0)
[23:50:28.312] Timer tick, asking Buildbucket for the build status
[23:50:28.758] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:28.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:44:0) after 1m0s
[23:51:29.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:44:0)
[23:51:29.460] Timer tick, asking Buildbucket for the build status
[23:51:29.723] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:29.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:45:0) after 1m0s
[23:52:29.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:45:0)
[23:52:29.800] Timer tick, asking Buildbucket for the build status
[23:52:29.872] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:29.872] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:46:0) after 1m0s
[23:53:29.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:46:0)
[23:53:29.949] Timer tick, asking Buildbucket for the build status
[23:53:30.056] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:30.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:47:0) after 1m0s
[23:54:30.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:47:0)
[23:54:30.431] Timer tick, asking Buildbucket for the build status
[23:54:32.164] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:32.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:48:0) after 1m0s
[23:55:32.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:48:0)
[23:55:32.296] Timer tick, asking Buildbucket for the build status
[23:55:32.361] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:49:0) after 1m0s
[23:56:32.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:49:0)
[23:56:32.489] Timer tick, asking Buildbucket for the build status
[23:56:32.587] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:32.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:50:0) after 1m0s
[23:57:32.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:50:0)
[23:57:32.640] Timer tick, asking Buildbucket for the build status
[23:57:32.890] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:32.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:51:0) after 1m0s
[23:58:32.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:51:0)
[23:58:32.966] Timer tick, asking Buildbucket for the build status
[23:58:33.402] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:33.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:52:0) after 1m0s
[23:59:33.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:52:0)
[23:59:33.391] Timer tick, asking Buildbucket for the build status
[23:59:33.494] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:33.494] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:53:0) after 1m0s
[00:00:33.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:53:0)
[00:00:33.495] Timer tick, asking Buildbucket for the build status
[00:00:33.608] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:33.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:54:0) after 1m0s
[00:01:33.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:54:0)
[00:01:33.631] Timer tick, asking Buildbucket for the build status
[00:01:33.727] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:33.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:55:0) after 1m0s
[00:02:33.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:55:0)
[00:02:33.807] Timer tick, asking Buildbucket for the build status
[00:02:33.937] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:33.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:56:0) after 1m0s
[00:03:33.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:56:0)
[00:03:33.979] Timer tick, asking Buildbucket for the build status
[00:03:34.133] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:34.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:57:0) after 1m0s
[00:04:34.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:57:0)
[00:04:34.226] Timer tick, asking Buildbucket for the build status
[00:04:34.352] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:34.352] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:58:0) after 1m0s
[00:05:34.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:58:0)
[00:05:34.882] Timer tick, asking Buildbucket for the build status
[00:05:35.419] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:35.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:59:0) after 1m0s
[00:06:36.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:59:0)
[00:06:36.036] Timer tick, asking Buildbucket for the build status
[00:06:36.172] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:36.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:60:0) after 1m0s
[00:07:36.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:60:0)
[00:07:36.280] Timer tick, asking Buildbucket for the build status
[00:07:36.400] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:36.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:61:0) after 1m0s
[00:08:36.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:61:0)
[00:08:36.429] Timer tick, asking Buildbucket for the build status
[00:08:36.511] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:36.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:62:0) after 1m0s
[00:09:36.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:62:0)
[00:09:36.745] Timer tick, asking Buildbucket for the build status
[00:09:37.209] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:37.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:63:0) after 1m0s
[00:10:37.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:63:0)
[00:10:37.349] Timer tick, asking Buildbucket for the build status
[00:10:37.457] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:37.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:64:0) after 1m0s
[00:11:37.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:64:0)
[00:11:37.831] Timer tick, asking Buildbucket for the build status
[00:11:38.023] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:38.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:65:0) after 1m0s
[00:12:38.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:65:0)
[00:12:38.103] Timer tick, asking Buildbucket for the build status
[00:12:38.625] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:38.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:66:0) after 1m0s
[00:13:38.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:66:0)
[00:13:38.861] Timer tick, asking Buildbucket for the build status
[00:13:38.969] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:38.969] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:67:0) after 1m0s
[00:14:39.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:67:0)
[00:14:39.094] Timer tick, asking Buildbucket for the build status
[00:14:39.213] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:39.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:68:0) after 1m0s
[00:15:39.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:68:0)
[00:15:39.271] Timer tick, asking Buildbucket for the build status
[00:15:39.398] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:39.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:69:0) after 1m0s
[00:16:39.468] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:69:0)
[00:16:39.468] Timer tick, asking Buildbucket for the build status
[00:16:39.741] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:39.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:70:0) after 1m0s
[00:17:39.762] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:70:0)
[00:17:39.762] Timer tick, asking Buildbucket for the build status
[00:17:39.919] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:39.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:71:0) after 1m0s
[00:18:39.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:71:0)
[00:18:39.985] Timer tick, asking Buildbucket for the build status
[00:18:40.080] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:40.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:72:0) after 1m0s
[00:19:40.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:72:0)
[00:19:40.098] Timer tick, asking Buildbucket for the build status
[00:19:40.176] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:40.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:73:0) after 1m0s
[00:20:40.190] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:73:0)
[00:20:40.190] Timer tick, asking Buildbucket for the build status
[00:20:40.281] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:40.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:74:0) after 1m0s
[00:21:40.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:74:0)
[00:21:40.330] Timer tick, asking Buildbucket for the build status
[00:21:40.438] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:40.438] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:75:0) after 1m0s
[00:22:40.487] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:75:0)
[00:22:40.487] Timer tick, asking Buildbucket for the build status
[00:22:40.948] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:40.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:76:0) after 1m0s
[00:23:40.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:76:0)
[00:23:40.992] Timer tick, asking Buildbucket for the build status
[00:23:41.138] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:41.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:77:0) after 1m0s
[00:24:41.187] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:77:0)
[00:24:41.187] Timer tick, asking Buildbucket for the build status
[00:24:41.260] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:41.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:78:0) after 1m0s
[00:25:41.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:78:0)
[00:25:41.254] Timer tick, asking Buildbucket for the build status
[00:25:41.347] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:41.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:79:0) after 1m0s
[00:26:41.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:79:0)
[00:26:41.391] Timer tick, asking Buildbucket for the build status
[00:26:42.046] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:42.046] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:80:0) after 1m0s
[00:27:42.077] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:80:0)
[00:27:42.077] Timer tick, asking Buildbucket for the build status
[00:27:42.162] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:42.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:81:0) after 1m0s
[00:28:42.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:81:0)
[00:28:42.206] Timer tick, asking Buildbucket for the build status
[00:28:42.287] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:42.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:82:0) after 1m0s
[00:29:42.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:82:0)
[00:29:42.332] Timer tick, asking Buildbucket for the build status
[00:29:42.465] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:42.465] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:83:0) after 1m0s
[00:30:42.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:83:0)
[00:30:42.575] Timer tick, asking Buildbucket for the build status
[00:30:42.655] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:42.655] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:84:0) after 1m0s
[00:31:42.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:84:0)
[00:31:42.651] Timer tick, asking Buildbucket for the build status
[00:31:42.753] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:42.753] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:85:0) after 1m0s
[00:32:42.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:85:0)
[00:32:42.770] Timer tick, asking Buildbucket for the build status
[00:32:42.886] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:42.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:86:0) after 1m0s
[00:33:42.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:86:0)
[00:33:42.911] Timer tick, asking Buildbucket for the build status
[00:33:43.011] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:43.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:87:0) after 1m0s
[00:34:43.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:87:0)
[00:34:43.021] Timer tick, asking Buildbucket for the build status
[00:34:43.164] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:43.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:88:0) after 1m0s
[00:35:43.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:88:0)
[00:35:43.139] Timer tick, asking Buildbucket for the build status
[00:35:43.340] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:43.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:89:0) after 1m0s
[00:36:43.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:89:0)
[00:36:43.386] Timer tick, asking Buildbucket for the build status
[00:36:43.487] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:43.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:90:0) after 1m0s
[00:37:43.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:90:0)
[00:37:43.574] Timer tick, asking Buildbucket for the build status
[00:37:43.667] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:43.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:91:0) after 1m0s
[00:38:43.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:91:0)
[00:38:43.713] Timer tick, asking Buildbucket for the build status
[00:38:43.811] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:43.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:92:0) after 1m0s
[00:39:43.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:92:0)
[00:39:43.796] Timer tick, asking Buildbucket for the build status
[00:39:43.948] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:43.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:93:0) after 1m0s
[00:40:44.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:93:0)
[00:40:44.008] Timer tick, asking Buildbucket for the build status
[00:40:44.101] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:44.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:94:0) after 1m0s
[00:41:45.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:94:0)
[00:41:45.240] Timer tick, asking Buildbucket for the build status
[00:41:47.681] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:95:0) after 1m0s
[00:42:49.040] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:95:0)
[00:42:49.040] Timer tick, asking Buildbucket for the build status
[00:42:49.124] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:49.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:96:0) after 1m0s
[00:43:49.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:96:0)
[00:43:49.288] Timer tick, asking Buildbucket for the build status
[00:43:49.381] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:49.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:97:0) after 1m0s
[00:44:49.483] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:97:0)
[00:44:49.483] Timer tick, asking Buildbucket for the build status
[00:44:49.569] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:49.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:98:0) after 1m0s
[00:45:49.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:98:0)
[00:45:49.790] Timer tick, asking Buildbucket for the build status
[00:45:49.878] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:49.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:99:0) after 1m0s
[00:46:49.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:99:0)
[00:46:49.926] Timer tick, asking Buildbucket for the build status
[00:46:50.444] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:50.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:100:0) after 1m0s
[00:47:50.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:100:0)
[00:47:50.555] Timer tick, asking Buildbucket for the build status
[00:47:50.953] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:50.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:101:0) after 1m0s
[00:48:50.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:101:0)
[00:48:50.999] Timer tick, asking Buildbucket for the build status
[00:48:51.359] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:51.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:102:0) after 1m0s
[00:49:51.491] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:102:0)
[00:49:51.491] Timer tick, asking Buildbucket for the build status
[00:49:51.567] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:51.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:103:0) after 1m0s
[00:50:51.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:103:0)
[00:50:51.590] Timer tick, asking Buildbucket for the build status
[00:50:51.771] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:51.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:104:0) after 1m0s
[00:51:51.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:104:0)
[00:51:51.816] Timer tick, asking Buildbucket for the build status
[00:51:51.926] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:51.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:105:0) after 1m0s
[00:52:51.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:105:0)
[00:52:51.976] Timer tick, asking Buildbucket for the build status
[00:52:52.557] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:52.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:106:0) after 1m0s
[00:53:54.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:106:0)
[00:53:54.613] Timer tick, asking Buildbucket for the build status
[00:53:54.740] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:54.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:107:0) after 1m0s
[00:54:55.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:107:0)
[00:54:55.748] Timer tick, asking Buildbucket for the build status
[00:54:57.482] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:57.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:108:0) after 1m0s
[00:55:58.297] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:108:0)
[00:55:58.297] Timer tick, asking Buildbucket for the build status
[00:55:58.404] Build 8853920804152761456: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:58.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019350866121396160:109:0) after 1m0s
[00:56:51.198] Received PubSub notification, asking Buildbucket for the build status
[00:56:51.341] Build 8853920804152761456: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:56:51.341] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614646610698147",
"created_by": "project:chromium",
"created_ts": "1614640151792520",
"failure_reason": "BUILD_FAILURE",
"id": "8853920804152761456",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"a8c353ed9c51ca1240f2525f496e3383cb5288c5\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- CrSettingsPrivacyPageV3Test.HappinessTrackingSurveysTests\"}, \"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\": \"a8c353ed9c51ca1240f2525f496e3383cb5288c5\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-43-612k\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22823, \"got_angle_revision\": \"5b82fa2e842475cd93c6a6119b6e07635054e836\", \"got_dawn_revision\": \"931182485579d2eec3b24c1f2df646870f80da68\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"a8c353ed9c51ca1240f2525f496e3383cb5288c5\", \"got_revision_cp\": \"refs/heads/master@{#858751}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"851ca4314ae4a367bcc4cabb20326029eff18492\", \"got_v8_revision_cp\": \"refs/heads/9.1.7@{#1}\", \"got_webrtc_revision\": \"376cf384ac689eca0bf8d4d1d3a3cf80888d3fbb\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33348}\", \"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\": \"a8c353ed9c51ca1240f2525f496e3383cb5288c5\", \"swarm_hashes_refs/heads/master(at){#858751}_without_patch\": {\"absl_hardening_tests\": \"b1c02a992f06eeba216f1b615f4799151e48b8fb\", \"accessibility_unittests\": \"5e64beccaa94b4414aa279f9fe1f45e3a1766f9c\", \"angle_unittests\": \"becdca359d314325ffecdba3bf65fc24ccc506dc\", \"app_list_unittests\": \"321a28dc3db9a22a9b54d60d2d84ad9498d45abd\", \"app_shell_unittests\": \"2afe0690fce1f92b434947bfd4aabee670552fee\", \"ash_unittests\": \"721077e48e16664a263c3dc4de4aeb30cb1ff71f\", \"aura_unittests\": \"c1d672457e81a9e91b4821dc2cf5beae60e6c04a\", \"base_unittests\": \"5d68a859cc22903b97962deca2651644cb6c05c7\", \"base_util_unittests\": \"64b3bb24b947878dfd6ee1014b0f2d5541692519\", \"blink_common_unittests\": \"2c51554558f81f06aa3eee51c68ebc3e29569374\", \"blink_fuzzer_unittests\": \"5948366511f63b589814eb73c528eca3b6873d00\", \"blink_heap_unittests\": \"79a50a9377a527ed96481bbf2fdd005590e1fcf1\", \"blink_platform_unittests\": \"32cb46e4f544d8135e01c274e3dc17c92f9ccd47\", \"blink_unittests\": \"b82dd67247ec3df92efc3d1715e465f44e9b52fa\", \"boringssl_crypto_tests\": \"5917e577a6933da5267d721c016cea2fa0b1b230\", \"boringssl_ssl_tests\": \"668f33ee90957b7f2d94bc20b7d226f86e34b684\", \"browser_tests\": \"acbe45c1a9c7bf9d874b05fdc7b60b60a093333d\", \"capture_unittests\": \"502d94adda1d2203276bdfdc852148971a32b42d\", \"cast_unittests\": \"83d6d12f9f3ec53cfbb126dc7c78f0f44a5a4e83\", \"cc_unittests\": \"ce957b1219df2fbea79685c8c79d6d12525a5fbe\", \"chrome_app_unittests\": \"1b7af6ee1b7c6bedaa49512679e0e8efe4712046\", \"chromedriver_unittests\": \"69a68a501cc7f4ebfef8a2d43e937295136829e0\", \"chromeos_components_unittests\": \"939992a479bd25127bb815c951740e7f730d2601\", \"chromeos_unittests\": \"59408f304de4ea917a174e345b61ac58cc4206bc\", \"color_unittests\": \"76c73afcbe418c423dc35a3956652ba4600d8bf2\", \"components_browsertests\": \"70e906c34215b90428bebd25db20afeb78590066\", \"components_unittests\": \"2965f4a597bec50943763dccb93a436de1e904ce\", \"compositor_unittests\": \"d9cc70aca06c92ea5df95684213d6422f4be0fb4\", \"content_browsertests\": \"5bad13e312c5388e1fb0cf992c7c1ffe4d0485b0\", \"content_unittests\": \"8015646a4804c0820990a67ba26d4e180c6d2826\", \"crashpad_tests\": \"274c93aa84573691c2b9518bfba2cdad53d96b46\", \"crypto_unittests\": \"5e0dd135bb24efb851e92382c27af345b1b59a39\", \"dbus_unittests\": \"b22360c1a650798ca313c7e64f73b4f7d0dab5fe\", \"device_unittests\": \"b602d906f8c9e5eceb36e2cfc836246d98cd57c8\", \"display_unittests\": \"60f7da2515fd23600b2e62ac8a93da7dad482c98\", \"events_unittests\": \"0c775895263b606fef283475653095f0ff2118eb\", \"exo_unittests\": \"2839d34830a481702ff99be2b243193e41206371\", \"extensions_browsertests\": \"7c6134b9e3f818cfff3f74561e33901d89ce21c1\", \"extensions_unittests\": \"ff181d90fb6f2c139f6b73287b74c4c5172d0fc5\", \"filesystem_service_unittests\": \"3254405f81a194ac22b0012a53b44630441897bf\", \"gcm_unit_tests\": \"feb7777da9251c4d33a0dbc2491714ed13dc1b58\", \"gfx_unittests\": \"3e739d083491aa8a7682becb0361835ad1780326\", \"gin_unittests\": \"c36124f58570d8cc0b7ceaf3cd5cb4b07c6131b3\", \"gl_unittests_ozone\": \"c2861068bc7517cf28cb6f04ac117dee06049501\", \"google_apis_unittests\": \"a830dc99054c16d62f30f1bcc0bd8930ca324035\", \"gpu_unittests\": \"6a25494ac87bbf915c0def3ce09844075cce9e90\", \"gwp_asan_unittests\": \"1f1d3b1f6b0f478814f1b615e54ac2fac6f1f81a\", \"interactive_ui_tests\": \"74261e66851c7c9e7762f10aed7b41734c67f2bc\", \"ipc_tests\": \"2a4226111fb4298985dff156ce368b6dfeaf4c48\", \"jingle_unittests\": \"ea9d4656ce0fe0977f0737164398f7a5b2c334ca\", \"keyboard_unittests\": \"d1e4deee01866ea52d4c6f118e3ad541570ca948\", \"latency_unittests\": \"800186c53f947938100f0b45c3aed22671573d03\", \"libjingle_xmpp_unittests\": \"7cd92a272d3c11b883720b14b9c4dc4e0c0f2af2\", \"liburlpattern_unittests\": \"aa93ac7c54b522356f3918aef646f27829270260\", \"media_blink_unittests\": \"38cf66eb82e8e3b7dc3ce68f719766d10cbef3b4\", \"media_unittests\": \"cfac1be1e6f008f8ca9f516434719e4fef98abab\", \"message_center_unittests\": \"ce3854ab5fed6a0211a68a767b726756f87e1fae\", \"midi_unittests\": \"68d3c7990a162341e4317f2077ef630e3a9b5812\", \"mojo_core_unittests\": \"a6a595518ab7e339cbfb6cd144a286fd14974a74\", \"mojo_unittests\": \"12b0e153c34c310ff4f632252b4799f7e9b672a0\", \"nacl_helper_nonsfi_unittests\": \"fffc5a61ddb693f16b3102a13396db5619eff836\", \"nacl_loader_unittests\": \"bbabe7aab710ccdd01ead5a5874076a81896a1ba\", \"native_theme_unittests\": \"67b71a6ba0e3afa40b999d08bc98cc6128c1fe51\", \"net_unittests\": \"62fdcf568849a31dfefe2ecbf1b5de2b0161a5e5\", \"ozone_gl_unittests\": \"712b2f34b99e096f653e0c973c59a4b5cb6e30c5\", \"ozone_unittests\": \"35228cf5a3465ca53f044541530b0388ea5a90b2\", \"ozone_x11_unittests\": \"732550c9aedc773a52331450c03569194e33ab99\", \"pdf_unittests\": \"18af3cbd531db4771bac6d836cdf2db395b10015\", \"perfetto_unittests\": \"1652231534f009136f64dd57a47ce8c1bf52a49d\", \"ppapi_unittests\": \"7b9763219debec5dfa6cbd8cc958c2f4868d3a39\", \"printing_unittests\": \"4a9ae57599511990d92b9fbdbfb58c1c4a2a9f89\", \"remoting_unittests\": \"091f45e5d6d669557d3d5db4919169073a8cb21c\", \"sandbox_linux_unittests\": \"f97e79f22f782447867009be5314ce8b2bfdede1\", \"service_manager_unittests\": \"188ef2fb7d2ce524d2116919610bd74d0de6fcb9\", \"services_unittests\": \"88a7b4a3b39047506b66253d50378ad3fb3610ba\", \"shell_dialogs_unittests\": \"09c5e851d50598921da4eaeb66fe53277003c48f\", \"shell_encryption_unittests\": \"96400c45ca5a41240a6796b8287b31c642137237\", \"skia_unittests\": \"a6028f1d75c9e8a50b88e1bb7920f022fc694fb8\", \"snapshot_unittests\": \"8c623e08a2af58342d01d45d5f33f91d63f28982\", \"sql_unittests\": \"b79d09181b4731514e08a3c3ae6f503f112417df\", \"storage_unittests\": \"db83e8a1079370d81c3a416879fa0667e71662e1\", \"sync_integration_tests\": \"8a55806ebe1b92c396dff8d6789edaa20f316291\", \"traffic_annotation_auditor_unittests\": \"c5ce4f69fd8673afb97cd982fc75ee521596981b\", \"ui_base_unittests\": \"51cba798a7b8095e6806f1999e7a38d54d4bef5f\", \"ui_chromeos_unittests\": \"ed3ed9deab17a713198793a81ae9936c21624f45\", \"ui_touch_selection_unittests\": \"7364ffd20d946a9d72c92549b091a89d0020f557\", \"unit_tests\": \"8e9fef66909f561800990600309b25cdf0d2ae36\", \"url_unittests\": \"418140358b5fd5391580b58b049c9aa755e494ac\", \"usage_time_limit_unittests\": \"28a1b2c78aabeee4a400b067f11567edb76afd32\", \"views_unittests\": \"a189e64ea9bfb59fc7bc5610d612dfb885e08e5b\", \"viz_unittests\": \"1eb883c9cee3bddd8186749135b7c7a035bf986a\", \"wayland_client_tests\": \"6136acfcbb3f225b0941723b91de2b42f7a49a6a\", \"wm_unittests\": \"3186a78d1a2417c2a6a0fef2d089c34eb58386e8\", \"wtf_unittests\": \"b30a75f2df3f39f733c47abee768a370639c66c0\", \"zlib_unittests\": \"f73e88a3b0a500ed7db782ed97b10c7019a80851\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_5f931a5519f78feef046af549827aa56dc2e9b17853b60b3d0ae8ebd533780ee_v2\", \"builder_7a9f94695aa83f7478015e01762e75301e67c95c681ec0592232bd343861e191_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-43-612k\"], \"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\": [\"5712-339372b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- CrSettingsPrivacyPageV3Test.HappinessTrackingSurveysTests\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614640333301852",
"status": "COMPLETED",
"status_changed_ts": "1614640333748048",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22823",
"builder:linux-chromeos-dbg",
"buildset:commit/git/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a8c353ed9c51ca1240f2525f496e3383cb5288c5",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019350866121396160",
"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/8853920804152761456/+/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:5208df0919f36410",
"user_agent:luci-scheduler"
],
"updated_ts": "1614646610698505",
"url": "https://ci.chromium.org/b/8853920804152761456",
"utcnow_ts": "1614646611330739"
}
}
[00:56:51.341] Invocation finished in 1h47m40.809734176s with status FAILED