[20:29:27.038] New invocation is queued and will start shortly
[20:29:28.147] Starting the invocation (attempt 1)
[20:29:28.215] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:29:28.216] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:29:28.216] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019723303024962480",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019723303024962480",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"gitiles_ref:refs/heads/master"
]
}
[20:29:29.071] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614284968297124",
"id": "8854293241041128320",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614284968724154",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22782",
"builder:linux-chromeos-dbg",
"buildset:commit/git/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019723303024962480",
"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/8854293241041128320/+/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": "1614284968724258",
"url": "https://ci.chromium.org/b/8854293241041128320",
"utcnow_ts": "1614284969063502"
}
}
[20:29:29.071] Task URL: https://ci.chromium.org/b/8854293241041128320
[20:29:29.071] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:2:0) after 1m0s
[20:30:16.162] Received PubSub notification, asking Buildbucket for the build status
[20:30:16.247] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:29.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:2:0)
[20:30:29.093] Timer tick, asking Buildbucket for the build status
[20:30:29.208] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:29.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:4:0) after 1m0s
[20:31:29.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:4:0)
[20:31:29.348] Timer tick, asking Buildbucket for the build status
[20:31:29.586] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:29.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:5:0) after 1m0s
[20:32:29.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:5:0)
[20:32:29.728] Timer tick, asking Buildbucket for the build status
[20:32:29.840] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:29.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:6:0) after 1m0s
[20:33:29.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:6:0)
[20:33:29.888] Timer tick, asking Buildbucket for the build status
[20:33:30.158] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:30.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:7:0) after 1m0s
[20:34:30.206] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:7:0)
[20:34:30.206] Timer tick, asking Buildbucket for the build status
[20:34:30.519] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:30.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:8:0) after 1m0s
[20:35:30.573] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:8:0)
[20:35:30.573] Timer tick, asking Buildbucket for the build status
[20:35:30.693] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:30.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:9:0) after 1m0s
[20:36:30.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:9:0)
[20:36:30.741] Timer tick, asking Buildbucket for the build status
[20:36:31.014] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:31.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:10:0) after 1m0s
[20:37:31.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:10:0)
[20:37:31.130] Timer tick, asking Buildbucket for the build status
[20:37:31.277] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:31.277] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:11:0) after 1m0s
[20:38:31.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:11:0)
[20:38:31.290] Timer tick, asking Buildbucket for the build status
[20:38:31.565] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:31.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:12:0) after 1m0s
[20:39:31.706] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:12:0)
[20:39:31.706] Timer tick, asking Buildbucket for the build status
[20:39:31.983] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:31.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:13:0) after 1m0s
[20:40:32.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:13:0)
[20:40:32.019] Timer tick, asking Buildbucket for the build status
[20:40:32.088] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:32.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:14:0) after 1m0s
[20:41:32.277] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:14:0)
[20:41:32.277] Timer tick, asking Buildbucket for the build status
[20:41:32.361] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:32.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:15:0) after 1m0s
[20:42:32.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:15:0)
[20:42:32.386] Timer tick, asking Buildbucket for the build status
[20:42:32.578] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:32.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:16:0) after 1m0s
[20:43:32.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:16:0)
[20:43:32.679] Timer tick, asking Buildbucket for the build status
[20:43:32.803] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:32.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:17:0) after 1m0s
[20:44:33.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:17:0)
[20:44:33.097] Timer tick, asking Buildbucket for the build status
[20:44:33.188] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:33.188] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:18:0) after 1m0s
[20:45:33.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:18:0)
[20:45:33.286] Timer tick, asking Buildbucket for the build status
[20:45:33.363] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:33.363] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:19:0) after 1m0s
[20:46:33.401] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:19:0)
[20:46:33.401] Timer tick, asking Buildbucket for the build status
[20:46:33.903] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:33.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:20:0) after 1m0s
[20:47:34.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:20:0)
[20:47:34.024] Timer tick, asking Buildbucket for the build status
[20:47:34.101] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:34.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:21:0) after 1m0s
[20:48:34.156] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:21:0)
[20:48:34.156] Timer tick, asking Buildbucket for the build status
[20:48:34.239] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:34.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:22:0) after 1m0s
[20:49:34.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:22:0)
[20:49:34.284] Timer tick, asking Buildbucket for the build status
[20:49:34.483] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:34.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:23:0) after 1m0s
[20:50:34.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:23:0)
[20:50:34.545] Timer tick, asking Buildbucket for the build status
[20:50:34.731] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:34.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:24:0) after 1m0s
[20:51:34.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:24:0)
[20:51:34.756] Timer tick, asking Buildbucket for the build status
[20:51:34.858] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:34.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:25:0) after 1m0s
[20:52:35.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:25:0)
[20:52:35.008] Timer tick, asking Buildbucket for the build status
[20:52:35.225] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:35.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:26:0) after 1m0s
[20:53:35.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:26:0)
[20:53:35.202] Timer tick, asking Buildbucket for the build status
[20:53:35.516] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:35.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:27:0) after 1m0s
[20:54:35.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:27:0)
[20:54:35.608] Timer tick, asking Buildbucket for the build status
[20:54:35.894] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:35.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:28:0) after 1m0s
[20:55:35.971] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:28:0)
[20:55:35.971] Timer tick, asking Buildbucket for the build status
[20:55:36.117] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:36.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:29:0) after 1m0s
[20:56:36.218] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:29:0)
[20:56:36.218] Timer tick, asking Buildbucket for the build status
[20:56:36.462] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:36.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:30:0) after 1m0s
[20:57:36.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:30:0)
[20:57:36.620] Timer tick, asking Buildbucket for the build status
[20:57:36.719] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:36.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:31:0) after 1m0s
[20:58:36.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:31:0)
[20:58:36.728] Timer tick, asking Buildbucket for the build status
[20:58:36.973] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:36.973] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:32:0) after 1m0s
[20:59:37.144] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:32:0)
[20:59:37.144] Timer tick, asking Buildbucket for the build status
[20:59:37.443] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:37.443] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:33:0) after 1m0s
[21:00:37.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:33:0)
[21:00:37.506] Timer tick, asking Buildbucket for the build status
[21:00:37.569] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:37.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:34:0) after 1m0s
[21:01:37.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:34:0)
[21:01:37.995] Timer tick, asking Buildbucket for the build status
[21:01:38.080] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:38.080] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:35:0) after 1m0s
[21:02:38.074] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:35:0)
[21:02:38.074] Timer tick, asking Buildbucket for the build status
[21:02:38.353] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:38.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:36:0) after 1m0s
[21:03:38.428] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:36:0)
[21:03:38.428] Timer tick, asking Buildbucket for the build status
[21:03:38.539] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:38.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:37:0) after 1m0s
[21:04:38.562] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:37:0)
[21:04:38.562] Timer tick, asking Buildbucket for the build status
[21:04:38.660] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:38.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:38:0) after 1m0s
[21:05:38.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:38:0)
[21:05:38.744] Timer tick, asking Buildbucket for the build status
[21:05:38.833] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:38.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:39:0) after 1m0s
[21:06:38.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:39:0)
[21:06:38.888] Timer tick, asking Buildbucket for the build status
[21:06:38.977] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:38.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:40:0) after 1m0s
[21:07:39.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:40:0)
[21:07:39.009] Timer tick, asking Buildbucket for the build status
[21:07:39.335] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:39.335] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:41:0) after 1m0s
[21:08:39.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:41:0)
[21:08:39.396] Timer tick, asking Buildbucket for the build status
[21:08:39.484] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:39.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:42:0) after 1m0s
[21:09:39.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:42:0)
[21:09:39.520] Timer tick, asking Buildbucket for the build status
[21:09:39.593] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:39.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:43:0) after 1m0s
[21:10:39.715] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:43:0)
[21:10:39.715] Timer tick, asking Buildbucket for the build status
[21:10:39.794] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:39.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:44:0) after 1m0s
[21:11:39.910] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:44:0)
[21:11:39.910] Timer tick, asking Buildbucket for the build status
[21:11:39.992] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:39.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:45:0) after 1m0s
[21:12:40.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:45:0)
[21:12:40.151] Timer tick, asking Buildbucket for the build status
[21:12:40.292] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:40.292] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:46:0) after 1m0s
[21:13:40.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:46:0)
[21:13:40.343] Timer tick, asking Buildbucket for the build status
[21:13:40.812] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:40.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:47:0) after 1m0s
[21:14:40.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:47:0)
[21:14:40.940] Timer tick, asking Buildbucket for the build status
[21:14:41.190] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:41.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:48:0) after 1m0s
[21:15:41.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:48:0)
[21:15:41.291] Timer tick, asking Buildbucket for the build status
[21:15:41.639] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:49:0) after 1m0s
[21:16:41.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:49:0)
[21:16:41.842] Timer tick, asking Buildbucket for the build status
[21:16:41.945] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:41.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:50:0) after 1m0s
[21:17:42.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:50:0)
[21:17:42.018] Timer tick, asking Buildbucket for the build status
[21:17:42.133] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:42.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:51:0) after 1m0s
[21:18:42.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:51:0)
[21:18:42.252] Timer tick, asking Buildbucket for the build status
[21:18:42.481] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:42.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:52:0) after 1m0s
[21:19:42.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:52:0)
[21:19:42.547] Timer tick, asking Buildbucket for the build status
[21:19:42.670] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:42.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:53:0) after 1m0s
[21:20:42.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:53:0)
[21:20:42.713] Timer tick, asking Buildbucket for the build status
[21:20:42.854] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:42.854] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:54:0) after 1m0s
[21:21:42.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:54:0)
[21:21:42.928] Timer tick, asking Buildbucket for the build status
[21:21:43.385] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:43.385] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:55:0) after 1m0s
[21:22:43.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:55:0)
[21:22:43.436] Timer tick, asking Buildbucket for the build status
[21:22:43.526] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:43.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:56:0) after 1m0s
[21:23:43.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:56:0)
[21:23:43.601] Timer tick, asking Buildbucket for the build status
[21:23:43.700] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:43.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:57:0) after 1m0s
[21:24:43.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:57:0)
[21:24:43.751] Timer tick, asking Buildbucket for the build status
[21:24:44.411] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:44.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:58:0) after 1m0s
[21:25:44.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:58:0)
[21:25:44.508] Timer tick, asking Buildbucket for the build status
[21:25:44.830] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:44.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:59:0) after 1m0s
[21:26:44.976] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:59:0)
[21:26:44.976] Timer tick, asking Buildbucket for the build status
[21:26:45.051] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:45.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:60:0) after 1m0s
[21:27:45.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:60:0)
[21:27:45.285] Timer tick, asking Buildbucket for the build status
[21:27:45.691] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:45.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:61:0) after 1m0s
[21:28:45.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:61:0)
[21:28:45.741] Timer tick, asking Buildbucket for the build status
[21:28:45.977] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:45.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:62:0) after 1m0s
[21:29:46.075] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:62:0)
[21:29:46.075] Timer tick, asking Buildbucket for the build status
[21:29:46.396] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:46.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:63:0) after 1m0s
[21:30:46.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:63:0)
[21:30:46.612] Timer tick, asking Buildbucket for the build status
[21:30:46.709] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:46.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:64:0) after 1m0s
[21:31:46.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:64:0)
[21:31:46.778] Timer tick, asking Buildbucket for the build status
[21:31:46.861] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:46.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:65:0) after 1m0s
[21:32:46.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:65:0)
[21:32:46.891] Timer tick, asking Buildbucket for the build status
[21:32:47.116] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:47.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:66:0) after 1m0s
[21:33:47.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:66:0)
[21:33:47.139] Timer tick, asking Buildbucket for the build status
[21:33:47.589] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:47.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:67:0) after 1m0s
[21:34:47.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:67:0)
[21:34:47.670] Timer tick, asking Buildbucket for the build status
[21:34:48.178] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:48.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:68:0) after 1m0s
[21:35:48.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:68:0)
[21:35:48.359] Timer tick, asking Buildbucket for the build status
[21:35:48.804] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:48.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:69:0) after 1m0s
[21:36:48.886] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:69:0)
[21:36:48.886] Timer tick, asking Buildbucket for the build status
[21:36:48.966] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:48.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:70:0) after 1m0s
[21:37:49.022] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:70:0)
[21:37:49.022] Timer tick, asking Buildbucket for the build status
[21:37:49.096] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:49.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:71:0) after 1m0s
[21:38:49.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:71:0)
[21:38:49.252] Timer tick, asking Buildbucket for the build status
[21:38:49.357] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:49.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:72:0) after 1m0s
[21:39:49.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:72:0)
[21:39:49.431] Timer tick, asking Buildbucket for the build status
[21:39:49.823] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:49.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:73:0) after 1m0s
[21:40:49.875] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:73:0)
[21:40:49.875] Timer tick, asking Buildbucket for the build status
[21:40:50.041] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:50.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:74:0) after 1m0s
[21:41:50.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:74:0)
[21:41:50.104] Timer tick, asking Buildbucket for the build status
[21:41:50.207] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:50.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:75:0) after 1m0s
[21:42:50.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:75:0)
[21:42:50.231] Timer tick, asking Buildbucket for the build status
[21:42:50.312] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:50.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:76:0) after 1m0s
[21:43:50.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:76:0)
[21:43:50.343] Timer tick, asking Buildbucket for the build status
[21:43:50.608] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:50.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:77:0) after 1m0s
[21:44:50.713] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:77:0)
[21:44:50.713] Timer tick, asking Buildbucket for the build status
[21:44:50.865] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:50.865] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:78:0) after 1m0s
[21:45:50.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:78:0)
[21:45:50.934] Timer tick, asking Buildbucket for the build status
[21:45:51.022] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:51.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:79:0) after 1m0s
[21:46:51.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:79:0)
[21:46:51.186] Timer tick, asking Buildbucket for the build status
[21:46:51.935] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:51.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:80:0) after 1m0s
[21:47:52.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:80:0)
[21:47:52.003] Timer tick, asking Buildbucket for the build status
[21:47:52.086] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:52.086] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:81:0) after 1m0s
[21:48:52.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:81:0)
[21:48:52.225] Timer tick, asking Buildbucket for the build status
[21:48:52.358] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:52.358] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:82:0) after 1m0s
[21:49:52.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:82:0)
[21:49:52.397] Timer tick, asking Buildbucket for the build status
[21:49:52.521] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:52.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:83:0) after 1m0s
[21:50:52.546] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:83:0)
[21:50:52.546] Timer tick, asking Buildbucket for the build status
[21:50:52.667] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:52.667] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:84:0) after 1m0s
[21:51:52.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:84:0)
[21:51:52.739] Timer tick, asking Buildbucket for the build status
[21:51:52.848] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:52.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:85:0) after 1m0s
[21:52:52.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:85:0)
[21:52:52.911] Timer tick, asking Buildbucket for the build status
[21:52:53.005] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:53.005] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:86:0) after 1m0s
[21:53:54.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:86:0)
[21:53:54.333] Timer tick, asking Buildbucket for the build status
[21:53:54.462] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:54.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:87:0) after 1m0s
[21:54:54.521] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:87:0)
[21:54:54.521] Timer tick, asking Buildbucket for the build status
[21:54:54.837] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:54.837] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:88:0) after 1m0s
[21:55:54.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:88:0)
[21:55:54.859] Timer tick, asking Buildbucket for the build status
[21:55:54.945] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:54.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:89:0) after 1m0s
[21:56:55.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:89:0)
[21:56:55.024] Timer tick, asking Buildbucket for the build status
[21:56:55.246] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:55.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:90:0) after 1m0s
[21:57:55.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:90:0)
[21:57:55.352] Timer tick, asking Buildbucket for the build status
[21:57:55.430] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:55.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:91:0) after 1m0s
[21:58:55.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:91:0)
[21:58:55.515] Timer tick, asking Buildbucket for the build status
[21:58:55.978] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:55.978] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:92:0) after 1m0s
[21:59:56.047] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:92:0)
[21:59:56.047] Timer tick, asking Buildbucket for the build status
[21:59:56.296] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:56.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:93:0) after 1m0s
[22:00:56.418] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:93:0)
[22:00:56.418] Timer tick, asking Buildbucket for the build status
[22:00:56.904] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:56.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:94:0) after 1m0s
[22:01:57.060] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:94:0)
[22:01:57.060] Timer tick, asking Buildbucket for the build status
[22:01:57.198] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:57.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:95:0) after 1m0s
[22:02:57.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:95:0)
[22:02:57.333] Timer tick, asking Buildbucket for the build status
[22:02:57.507] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:57.507] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:96:0) after 1m0s
[22:03:57.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:96:0)
[22:03:57.568] Timer tick, asking Buildbucket for the build status
[22:03:57.673] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:57.673] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:97:0) after 1m0s
[22:04:57.832] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:97:0)
[22:04:57.832] Timer tick, asking Buildbucket for the build status
[22:04:58.142] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:58.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:98:0) after 1m0s
[22:05:58.209] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:98:0)
[22:05:58.209] Timer tick, asking Buildbucket for the build status
[22:05:58.317] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:58.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:99:0) after 1m0s
[22:06:58.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:99:0)
[22:06:58.442] Timer tick, asking Buildbucket for the build status
[22:06:58.535] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:58.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:100:0) after 1m0s
[22:07:58.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:100:0)
[22:07:58.688] Timer tick, asking Buildbucket for the build status
[22:07:58.907] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:58.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:101:0) after 1m0s
[22:08:59.904] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:101:0)
[22:08:59.905] Timer tick, asking Buildbucket for the build status
[22:08:59.981] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:59.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:102:0) after 1m0s
[22:09:59.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:102:0)
[22:09:59.986] Timer tick, asking Buildbucket for the build status
[22:10:00.219] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:00.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:103:0) after 1m0s
[22:11:00.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:103:0)
[22:11:00.720] Timer tick, asking Buildbucket for the build status
[22:11:00.874] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:00.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:104:0) after 1m0s
[22:12:01.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:104:0)
[22:12:01.533] Timer tick, asking Buildbucket for the build status
[22:12:01.611] Build 8854293241041128320: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:01.611] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019723303024962480:105:0) after 1m0s
[22:13:00.339] Received PubSub notification, asking Buildbucket for the build status
[22:13:00.425] Build 8854293241041128320: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:13:00.425] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614291179881766",
"created_by": "project:chromium",
"created_ts": "1614284968297124",
"failure_reason": "BUILD_FAILURE",
"id": "8854293241041128320",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- UpdateRequiredScreenTest.TestUpdateOverMeteredNetwork\\n\\n- BetterUpdateScreenTest.TestBatteryWarningDuringUpdateStages\\n\\n- MediaRouterIntegrationBrowserTest.CloseOnError\\n\\n- BetterUpdateScreenTest.TestUpdateCompletedRebootNeeded\\n\\n- ...9 more failure(s) (13 total)...\\n\\n**ash_unittests** failed because of:\\n\\n- UpdateNotificationControllerTest.VisibilityAfterUpdateRequiringFactoryReset\\n\\n- AssistantAlarmTimerControllerTest.TimerNotificationHasExpectedTitleV2\\n\\n- PciePeripheralNotificationControllerTest.GuestNotificationTbtOnly\\n\\n- UpdateNotificationControllerTest.VisibilityAfterRollback\\n\\n- ...9 more failure(s) (13 total)...\"}, \"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\": \"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\", \"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-23-cds6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22782, \"got_angle_revision\": \"9b1c569b14e90765cdd7c07e449400e88f1d6c45\", \"got_dawn_revision\": \"545a6970cbe9e986dd25e01f7ecf2f9a1b17c756\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\", \"got_revision_cp\": \"refs/heads/master@{#857806}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"349abccec8f7ebd1259de11965d58790a76b0ba4\", \"got_v8_revision\": \"bd0108b4c88e0d6f2350cb79b5f363fbd02f3eb7\", \"got_v8_revision_cp\": \"refs/heads/9.0.257@{#1}\", \"got_webrtc_revision\": \"bb52bdf09516ca548c4aff50526eda561f239bc0\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33341}\", \"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\": \"fb5e3df8b82487e43c6d9ba4efbf2932840f1f42\", \"swarm_hashes_refs/heads/master(at){#857806}_without_patch\": {\"absl_hardening_tests\": \"c17b11da83e2e2bc3249e0557ee671e56d357626\", \"accessibility_unittests\": \"8f2f482a6963ec54a7886536a71f831bd64e238b\", \"angle_unittests\": \"7b5cfea4b57577bbea49c2bfce23b2b286d3765c\", \"app_list_unittests\": \"2d9a48addd30fe23729f3b54af5e24bdda9d4061\", \"app_shell_unittests\": \"f1ddf891f1a7c873a91c6a0515b67762c0fd2821\", \"ash_unittests\": \"71090b9150c71bf2e2c57bc30eebe9fb30d608a0\", \"aura_unittests\": \"dad13e153b0951169f6816e710d65f65c70996fa\", \"base_unittests\": \"5e2741864f80c623f981e55fa19733273746283b\", \"base_util_unittests\": \"9f2cd38aba15d93bee914a51391e3e1a23e4e638\", \"blink_common_unittests\": \"238f4ed1b3e6bff429f4a0cd1661d173c50bcb78\", \"blink_fuzzer_unittests\": \"1769bf96b144207285e733a8d9acc278181772d0\", \"blink_heap_unittests\": \"35e0a91dde936d5878f2eef845df3bd38fa936de\", \"blink_platform_unittests\": \"9a1000db127d384321a76b113cfaa8cadfdbf1f9\", \"blink_unittests\": \"249615d3743fe5e659e6e7c68d2922bb452920d3\", \"boringssl_crypto_tests\": \"46161f5909c485d20b4dfe3b4e2afba2458f014c\", \"boringssl_ssl_tests\": \"b3b6c33451513ea34b5a667fb65028724a85d5ee\", \"browser_tests\": \"e00d7d8d0dbfbc294faf87398ebd6652be335820\", \"capture_unittests\": \"98e7b92e47496d2fa782b9a4ec8bf993bd52a6f3\", \"cast_unittests\": \"30eb740c60c4ae2f6e319e6ea858921e07bb805a\", \"cc_unittests\": \"43e52f2f431cd745347c29580c55f180487935b3\", \"chrome_app_unittests\": \"e93f9fd1afa6ad28080d9dbb7fc4b62676b38a7f\", \"chromedriver_unittests\": \"74f245a9caca4ba409bb306ba2a01d5d30f0bad0\", \"chromeos_components_unittests\": \"ff5cc09ac4af7848afd0d0e3492d7c9e9ee3f558\", \"chromeos_unittests\": \"e9055202029e04f635d3fb63bc7c7b679bd2746a\", \"color_unittests\": \"fa8c0cf2a2124cb04e433642e79dcd731db27121\", \"components_browsertests\": \"0f68e682f3e582de121b0d24d7c90c38ebbde58d\", \"components_unittests\": \"02f0718f7c73102f9dddd7a5af9de0fc76a3325d\", \"compositor_unittests\": \"eda08cc0f78c9cf76e941d6f476775671c19e34d\", \"content_browsertests\": \"495cacf6ae4389e2b95c42ec606362e5f3ec6a73\", \"content_unittests\": \"ffd3c79e7b4c18ca275ec41696a21ed148a03ae7\", \"crashpad_tests\": \"d52ccfab64c4ff8598924a0cbc3bf6044b54fbb7\", \"crypto_unittests\": \"8191a1bc4e190d7b863cb17b117856c7c442c33f\", \"dbus_unittests\": \"f8467283d1029b9baf2774bcfc5b889cc9e97d51\", \"device_unittests\": \"60fadad7b31de86b11b4d8a3fbfb0afc401e3d5a\", \"display_unittests\": \"f4bb2af12dc9bdeb27abbe29e43b6055fdb64dde\", \"events_unittests\": \"bf68f5b081be26a56b515ed47ee529e9bb6e5ee1\", \"exo_unittests\": \"2ec7b20f6c1797d95c5bea794b2381e681dcf4ce\", \"extensions_browsertests\": \"38dd2533c17b3365c7c53fe06dc0f76d97ab955b\", \"extensions_unittests\": \"a25a06ca23ead423deb9e79be2d6916bc29de5cd\", \"filesystem_service_unittests\": \"179e0e83e5eb2eed04de631f43d21dcb6da02de2\", \"gcm_unit_tests\": \"cf3ca4e69286d2669eaed67c1864080b2dfa942b\", \"gfx_unittests\": \"388c339ea78c6b2f84361893a240f6e41d6ef856\", \"gin_unittests\": \"20f95be9ec1fac9d889fbab93337bdecb36f0492\", \"gl_unittests_ozone\": \"96de1ddd30ed3f00aacc549eb580797c319cd0c6\", \"google_apis_unittests\": \"c48216bf9d3e5a1a248e250c76f080f239c5c7d0\", \"gpu_unittests\": \"1f16b1248bb861298cf3af53f1b502caf21ba525\", \"gwp_asan_unittests\": \"08475482c6a339ed461c1190651014825e58dea7\", \"interactive_ui_tests\": \"68c93a056412ab0ff389c0891a6b991bf70b5684\", \"ipc_tests\": \"56017e921410e758514cabb3cb6c5c87e05a2696\", \"jingle_unittests\": \"68f11127839bd4dca62275901f5e3e5f3e7fe6f4\", \"keyboard_unittests\": \"3fa778361358da46a672a2a58b3e90747c1810f0\", \"latency_unittests\": \"14a32a910d7f54377f0c9f8c7b575ad74201ed99\", \"libjingle_xmpp_unittests\": \"11f04a960f90a64daaef103fe24e7eab79826f6c\", \"liburlpattern_unittests\": \"7325faa8ac3eb44c0660ced100bf06799747321d\", \"media_blink_unittests\": \"ad8cb364970d3acdf85f6a4593cc3a0a2aa0b734\", \"media_unittests\": \"08a8710c2784ebe824cee7b8fe70c2d1a97abee9\", \"message_center_unittests\": \"ecf10961ad85b3325a040800d751df59efe9eb03\", \"midi_unittests\": \"cceecb91365a0749f7ff8f2224ef77e6c668aaee\", \"mojo_core_unittests\": \"e7093c757636347b3b49bec6326d45c9d1d4c056\", \"mojo_unittests\": \"f12dfb5eac54d1403ce22e8f3073aca32b156954\", \"nacl_helper_nonsfi_unittests\": \"543d984f41848cb8a69120a170ba0033c7d15df9\", \"nacl_loader_unittests\": \"281809a91ed8ea6e0f7fac7636c1d1e5485982c9\", \"native_theme_unittests\": \"5bfd8b903ac84bcc84d40589ef2b45ec58f698a4\", \"net_unittests\": \"05a3eba08869994bd3a522f4ca5775b7c17bd3f7\", \"ozone_gl_unittests\": \"075ac5f3d62005ffe1b4bff5cd46ae706a654ed2\", \"ozone_unittests\": \"07c387db0c3b822f243784f9e0f53b5a464a4743\", \"ozone_x11_unittests\": \"4d2b0be37ea5e33cbdef69b504aa1e8c81a15ac1\", \"pdf_unittests\": \"912a5ebba01765c845342f666ef7efd38b0f54e7\", \"perfetto_unittests\": \"2c90b2bf1e54589d7c2c009f539c3f666fa76577\", \"ppapi_unittests\": \"c535c5230a6e99ac4d26ccc2484afd890d43ce78\", \"printing_unittests\": \"4e0a3ea2ea7c8058eeedc1b43252a45e06f6ccf0\", \"remoting_unittests\": \"3288dd2a06889bdefd0a17e6885d0a3f57819d1b\", \"sandbox_linux_unittests\": \"5b8f5b074de3d7a229a6d609d6f1940f46b935c4\", \"service_manager_unittests\": \"a1d41dc5bf35d46c1a165822689e1568083c1150\", \"services_unittests\": \"2e151d05cc0d95224ed317ff841f3f4478da5992\", \"shell_dialogs_unittests\": \"94ac7fc8e48cd3091d1dbc972bcac32524f689c1\", \"shell_encryption_unittests\": \"2958a19925fa46f0b7fdd3b2a25cf2f33eecbcb4\", \"skia_unittests\": \"f6d39189fb4c19d04a9b1d9f2cb1a8b9e2680efb\", \"snapshot_unittests\": \"6d0442051a7c8a8aaac31135bffc7aa127252eff\", \"sql_unittests\": \"f43f60b7170255b747f9585ef1dcc2791471ac32\", \"storage_unittests\": \"a8a6dc169663883fbabcb68ed5416fd69da71f2c\", \"sync_integration_tests\": \"b8511d733d089283585ee8c43f7a8199324f63c5\", \"traffic_annotation_auditor_unittests\": \"1546c093aafeb34db6a121af5724e4be35570072\", \"ui_base_unittests\": \"4dffd12124e3581186cc4bafbe4c8be98e4524ad\", \"ui_chromeos_unittests\": \"ae0c61fbee4f137ab027546b502e2b92b37a9981\", \"ui_touch_selection_unittests\": \"29a318b56e0d107fbdb70d7833aad58fe96628ea\", \"unit_tests\": \"e74b16187de59881686346e02ef09125f7842b75\", \"url_unittests\": \"5b563987121ac643bcee3e4cbbb08dd59fb6a2e6\", \"usage_time_limit_unittests\": \"76de2a7f21514f9b5de7620432e8657cb4095b64\", \"views_unittests\": \"fa23bfd7e07079cef5949f8f94f9b4e47c0bf9d3\", \"viz_unittests\": \"2553e547d74ae9f89180e00b9626e3b7dbed6586\", \"wayland_client_tests\": \"4ee43ce513b9448424daeff5ab00dabe1fbb87b7\", \"wm_unittests\": \"b177038a2b44ad876980263f37426136187596ec\", \"wtf_unittests\": \"c3532e236dcdcdc54f4cf76d239be16b1b6fb840\", \"zlib_unittests\": \"9652abb0e71faeb898fac937f1496380fdc6387e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_288b090d6274f2a2f913a0241f3e1a83c28ff98db6eccb4d2a91107c37eb954f_v2\", \"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_423c17966b99e0a79c01db6cfc0136b5313fefdfff3f88d25a8a4e9f8c30f88c_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_5f9879dd307b3e3de87d4273aaf77dfc3adf50a63c1d75c3b245bfdff463a933_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_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-23-cds6\"], \"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-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**browser_tests** failed because of:\\n\\n- UpdateRequiredScreenTest.TestUpdateOverMeteredNetwork\\n\\n- BetterUpdateScreenTest.TestBatteryWarningDuringUpdateStages\\n\\n- MediaRouterIntegrationBrowserTest.CloseOnError\\n\\n- BetterUpdateScreenTest.TestUpdateCompletedRebootNeeded\\n\\n- ...9 more failure(s) (13 total)...\\n\\n**ash_unittests** failed because of:\\n\\n- UpdateNotificationControllerTest.VisibilityAfterUpdateRequiringFactoryReset\\n\\n- AssistantAlarmTimerControllerTest.TimerNotificationHasExpectedTitleV2\\n\\n- PciePeripheralNotificationControllerTest.GuestNotificationTbtOnly\\n\\n- UpdateNotificationControllerTest.VisibilityAfterRollback\\n\\n- ...9 more failure(s) (13 total)...\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614285014617646",
"status": "COMPLETED",
"status_changed_ts": "1614285015290144",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22782",
"builder:linux-chromeos-dbg",
"buildset:commit/git/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/fb5e3df8b82487e43c6d9ba4efbf2932840f1f42",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019723303024962480",
"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/8854293241041128320/+/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:51f3b35f921c7d10",
"user_agent:luci-scheduler"
],
"updated_ts": "1614291179882282",
"url": "https://ci.chromium.org/b/8854293241041128320",
"utcnow_ts": "1614291180416558"
}
}
[22:13:00.425] Invocation finished in 1h43m33.403310125s with status FAILED