[20:00:48.059] New invocation is queued and will start shortly
[20:00:49.132] Starting the invocation (attempt 1)
[20:00:49.164] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:00:49.164] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:00:49.164] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9018637941907528368",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"69fc2acf3132a4a89829a3264e2582cbfd1a131c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9018637941907528368",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"gitiles_ref:refs/heads/master"
]
}
[20:00:49.929] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1615320049308403",
"id": "8853207879935486128",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"69fc2acf3132a4a89829a3264e2582cbfd1a131c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615320049725241",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22926",
"builder:linux-chromeos-dbg",
"buildset:commit/git/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018637941907528368",
"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/8853207879935486128/+/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": "1615320049726036",
"url": "https://ci.chromium.org/b/8853207879935486128",
"utcnow_ts": "1615320049923187"
}
}
[20:00:49.929] Task URL: https://ci.chromium.org/b/8853207879935486128
[20:00:49.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:2:0) after 1m0s
[20:00:54.299] Received PubSub notification, asking Buildbucket for the build status
[20:00:54.408] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:49.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:2:0)
[20:01:49.980] Timer tick, asking Buildbucket for the build status
[20:01:50.122] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:01:50.122] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:4:0) after 1m0s
[20:02:50.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:4:0)
[20:02:50.274] Timer tick, asking Buildbucket for the build status
[20:02:50.368] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:02:50.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:5:0) after 1m0s
[20:03:50.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:5:0)
[20:03:50.425] Timer tick, asking Buildbucket for the build status
[20:03:50.496] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:03:50.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:6:0) after 1m0s
[20:04:50.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:6:0)
[20:04:50.536] Timer tick, asking Buildbucket for the build status
[20:04:50.624] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:04:50.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:7:0) after 1m0s
[20:05:51.845] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:7:0)
[20:05:51.845] Timer tick, asking Buildbucket for the build status
[20:05:51.946] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:05:51.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:8:0) after 1m0s
[20:06:52.111] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:8:0)
[20:06:52.111] Timer tick, asking Buildbucket for the build status
[20:06:52.190] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:06:52.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:9:0) after 1m0s
[20:07:52.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:9:0)
[20:07:52.264] Timer tick, asking Buildbucket for the build status
[20:07:52.404] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:07:52.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:10:0) after 1m0s
[20:08:52.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:10:0)
[20:08:52.584] Timer tick, asking Buildbucket for the build status
[20:08:52.669] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:08:52.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:11:0) after 1m0s
[20:09:52.753] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:11:0)
[20:09:52.753] Timer tick, asking Buildbucket for the build status
[20:09:53.023] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:09:53.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:12:0) after 1m0s
[20:10:53.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:12:0)
[20:10:53.197] Timer tick, asking Buildbucket for the build status
[20:10:53.376] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:10:53.376] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:13:0) after 1m0s
[20:11:53.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:13:0)
[20:11:53.474] Timer tick, asking Buildbucket for the build status
[20:11:53.723] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:11:53.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:14:0) after 1m0s
[20:12:53.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:14:0)
[20:12:53.885] Timer tick, asking Buildbucket for the build status
[20:12:54.111] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:12:54.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:15:0) after 1m0s
[20:13:54.182] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:15:0)
[20:13:54.182] Timer tick, asking Buildbucket for the build status
[20:13:54.274] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:13:54.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:16:0) after 1m0s
[20:14:54.439] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:16:0)
[20:14:54.439] Timer tick, asking Buildbucket for the build status
[20:14:54.532] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:14:54.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:17:0) after 1m0s
[20:15:54.575] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:17:0)
[20:15:54.575] Timer tick, asking Buildbucket for the build status
[20:15:54.669] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:15:54.669] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:18:0) after 1m0s
[20:16:54.677] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:18:0)
[20:16:54.677] Timer tick, asking Buildbucket for the build status
[20:16:54.898] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:16:54.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:19:0) after 1m0s
[20:17:54.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:19:0)
[20:17:54.990] Timer tick, asking Buildbucket for the build status
[20:17:55.160] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:17:55.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:20:0) after 1m0s
[20:18:55.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:20:0)
[20:18:55.205] Timer tick, asking Buildbucket for the build status
[20:18:55.337] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:18:55.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:21:0) after 1m0s
[20:19:55.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:21:0)
[20:19:55.427] Timer tick, asking Buildbucket for the build status
[20:19:55.521] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:19:55.521] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:22:0) after 1m0s
[20:20:55.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:22:0)
[20:20:55.661] Timer tick, asking Buildbucket for the build status
[20:20:55.856] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:20:55.856] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:23:0) after 1m0s
[20:21:56.008] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:23:0)
[20:21:56.008] Timer tick, asking Buildbucket for the build status
[20:21:56.207] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:21:56.207] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:24:0) after 1m0s
[20:22:56.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:24:0)
[20:22:56.341] Timer tick, asking Buildbucket for the build status
[20:22:56.425] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:22:56.425] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:25:0) after 1m0s
[20:23:56.514] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:25:0)
[20:23:56.514] Timer tick, asking Buildbucket for the build status
[20:23:56.584] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:23:56.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:26:0) after 1m0s
[20:24:56.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:26:0)
[20:24:56.609] Timer tick, asking Buildbucket for the build status
[20:24:56.919] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:24:56.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:27:0) after 1m0s
[20:25:56.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:27:0)
[20:25:56.921] Timer tick, asking Buildbucket for the build status
[20:25:57.014] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:25:57.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:28:0) after 1m0s
[20:26:57.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:28:0)
[20:26:57.045] Timer tick, asking Buildbucket for the build status
[20:26:57.110] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:26:57.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:29:0) after 1m0s
[20:27:57.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:29:0)
[20:27:57.203] Timer tick, asking Buildbucket for the build status
[20:27:57.273] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:27:57.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:30:0) after 1m0s
[20:28:57.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:30:0)
[20:28:57.252] Timer tick, asking Buildbucket for the build status
[20:28:57.321] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:57.321] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:31:0) after 1m0s
[20:29:57.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:31:0)
[20:29:57.313] Timer tick, asking Buildbucket for the build status
[20:29:57.456] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:57.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:32:0) after 1m0s
[20:30:57.476] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:32:0)
[20:30:57.476] Timer tick, asking Buildbucket for the build status
[20:30:57.576] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:57.576] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:33:0) after 1m0s
[20:31:57.676] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:33:0)
[20:31:57.676] Timer tick, asking Buildbucket for the build status
[20:31:57.774] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:57.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:34:0) after 1m0s
[20:32:57.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:34:0)
[20:32:57.785] Timer tick, asking Buildbucket for the build status
[20:32:57.874] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:57.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:35:0) after 1m0s
[20:33:57.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:35:0)
[20:33:57.932] Timer tick, asking Buildbucket for the build status
[20:33:58.037] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:58.037] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:36:0) after 1m0s
[20:34:58.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:36:0)
[20:34:58.076] Timer tick, asking Buildbucket for the build status
[20:34:58.224] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:58.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:37:0) after 1m0s
[20:35:58.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:37:0)
[20:35:58.292] Timer tick, asking Buildbucket for the build status
[20:35:58.444] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:58.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:38:0) after 1m0s
[20:36:58.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:38:0)
[20:36:58.485] Timer tick, asking Buildbucket for the build status
[20:36:58.559] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:58.559] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:39:0) after 1m0s
[20:37:58.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:39:0)
[20:37:58.589] Timer tick, asking Buildbucket for the build status
[20:37:58.801] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:58.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:40:0) after 1m0s
[20:38:58.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:40:0)
[20:38:58.824] Timer tick, asking Buildbucket for the build status
[20:38:58.889] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:58.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:41:0) after 1m0s
[20:39:58.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:41:0)
[20:39:58.922] Timer tick, asking Buildbucket for the build status
[20:39:59.004] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:59.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:42:0) after 1m0s
[20:40:59.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:42:0)
[20:40:59.048] Timer tick, asking Buildbucket for the build status
[20:40:59.159] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:59.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:43:0) after 1m0s
[20:41:59.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:43:0)
[20:41:59.221] Timer tick, asking Buildbucket for the build status
[20:41:59.297] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:59.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:44:0) after 1m0s
[20:42:59.409] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:44:0)
[20:42:59.409] Timer tick, asking Buildbucket for the build status
[20:42:59.486] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:59.486] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:45:0) after 1m0s
[20:43:59.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:45:0)
[20:43:59.564] Timer tick, asking Buildbucket for the build status
[20:43:59.649] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:59.649] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:46:0) after 1m0s
[20:44:59.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:46:0)
[20:44:59.700] Timer tick, asking Buildbucket for the build status
[20:44:59.938] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:59.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:47:0) after 1m0s
[20:46:00.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:47:0)
[20:46:00.055] Timer tick, asking Buildbucket for the build status
[20:46:01.000] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:01.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:48:0) after 1m0s
[20:47:01.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:48:0)
[20:47:01.030] Timer tick, asking Buildbucket for the build status
[20:47:01.459] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:01.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:49:0) after 1m0s
[20:48:01.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:49:0)
[20:48:01.505] Timer tick, asking Buildbucket for the build status
[20:48:01.720] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:01.721] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:50:0) after 1m0s
[20:49:01.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:50:0)
[20:49:01.769] Timer tick, asking Buildbucket for the build status
[20:49:01.876] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:01.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:51:0) after 1m0s
[20:50:01.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:51:0)
[20:50:01.939] Timer tick, asking Buildbucket for the build status
[20:50:02.052] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:52:0) after 1m0s
[20:51:02.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:52:0)
[20:51:02.033] Timer tick, asking Buildbucket for the build status
[20:51:02.162] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:02.162] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:53:0) after 1m0s
[20:52:02.227] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:53:0)
[20:52:02.227] Timer tick, asking Buildbucket for the build status
[20:52:02.535] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:02.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:54:0) after 1m0s
[20:53:02.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:54:0)
[20:53:02.594] Timer tick, asking Buildbucket for the build status
[20:53:02.782] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:02.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:55:0) after 1m0s
[20:54:02.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:55:0)
[20:54:02.840] Timer tick, asking Buildbucket for the build status
[20:54:02.929] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:02.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:56:0) after 1m0s
[20:55:02.984] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:56:0)
[20:55:02.984] Timer tick, asking Buildbucket for the build status
[20:55:03.130] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:03.130] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:57:0) after 1m0s
[20:56:03.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:57:0)
[20:56:03.143] Timer tick, asking Buildbucket for the build status
[20:56:03.238] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:03.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:58:0) after 1m0s
[20:57:03.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:58:0)
[20:57:03.280] Timer tick, asking Buildbucket for the build status
[20:57:03.348] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:03.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:59:0) after 1m0s
[20:58:03.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:59:0)
[20:58:03.425] Timer tick, asking Buildbucket for the build status
[20:58:03.705] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:03.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:60:0) after 1m0s
[20:59:03.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:60:0)
[20:59:03.731] Timer tick, asking Buildbucket for the build status
[20:59:03.810] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:03.810] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:61:0) after 1m0s
[21:00:04.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:61:0)
[21:00:04.016] Timer tick, asking Buildbucket for the build status
[21:00:04.350] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:04.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:62:0) after 1m0s
[21:01:04.731] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:62:0)
[21:01:04.731] Timer tick, asking Buildbucket for the build status
[21:01:04.905] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:04.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:63:0) after 1m0s
[21:02:05.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:63:0)
[21:02:05.050] Timer tick, asking Buildbucket for the build status
[21:02:05.165] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:05.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:64:0) after 1m0s
[21:03:05.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:64:0)
[21:03:05.260] Timer tick, asking Buildbucket for the build status
[21:03:05.344] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:05.344] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:65:0) after 1m0s
[21:04:05.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:65:0)
[21:04:05.362] Timer tick, asking Buildbucket for the build status
[21:04:05.457] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:05.457] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:66:0) after 1m0s
[21:05:05.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:66:0)
[21:05:05.602] Timer tick, asking Buildbucket for the build status
[21:05:05.675] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:05.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:67:0) after 1m0s
[21:06:05.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:67:0)
[21:06:05.743] Timer tick, asking Buildbucket for the build status
[21:06:05.870] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:05.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:68:0) after 1m0s
[21:07:05.930] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:68:0)
[21:07:05.930] Timer tick, asking Buildbucket for the build status
[21:07:06.031] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:06.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:69:0) after 1m0s
[21:08:06.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:69:0)
[21:08:06.053] Timer tick, asking Buildbucket for the build status
[21:08:06.128] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:06.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:70:0) after 1m0s
[21:09:06.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:70:0)
[21:09:06.176] Timer tick, asking Buildbucket for the build status
[21:09:06.340] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:06.340] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:71:0) after 1m0s
[21:10:06.394] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:71:0)
[21:10:06.394] Timer tick, asking Buildbucket for the build status
[21:10:07.578] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:07.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:72:0) after 1m0s
[21:11:07.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:72:0)
[21:11:07.604] Timer tick, asking Buildbucket for the build status
[21:11:07.701] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:07.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:73:0) after 1m0s
[21:12:08.323] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:73:0)
[21:12:08.323] Timer tick, asking Buildbucket for the build status
[21:12:08.525] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:08.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:74:0) after 1m0s
[21:13:09.042] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:74:0)
[21:13:09.042] Timer tick, asking Buildbucket for the build status
[21:13:09.174] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:09.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:75:0) after 1m0s
[21:14:11.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:75:0)
[21:14:11.812] Timer tick, asking Buildbucket for the build status
[21:14:11.915] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:11.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:76:0) after 1m0s
[21:15:12.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:76:0)
[21:15:12.216] Timer tick, asking Buildbucket for the build status
[21:15:12.361] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:12.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:77:0) after 1m0s
[21:16:12.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:77:0)
[21:16:12.619] Timer tick, asking Buildbucket for the build status
[21:16:12.938] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:12.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:78:0) after 1m0s
[21:17:12.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:78:0)
[21:17:12.958] Timer tick, asking Buildbucket for the build status
[21:17:13.084] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:13.084] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:79:0) after 1m0s
[21:18:13.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:79:0)
[21:18:13.167] Timer tick, asking Buildbucket for the build status
[21:18:13.512] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:13.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:80:0) after 1m0s
[21:19:14.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:80:0)
[21:19:14.100] Timer tick, asking Buildbucket for the build status
[21:19:14.177] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:14.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:81:0) after 1m0s
[21:20:14.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:81:0)
[21:20:14.225] Timer tick, asking Buildbucket for the build status
[21:20:14.319] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:14.319] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:82:0) after 1m0s
[21:21:14.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:82:0)
[21:21:14.343] Timer tick, asking Buildbucket for the build status
[21:21:14.434] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:14.434] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:83:0) after 1m0s
[21:22:14.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:83:0)
[21:22:14.475] Timer tick, asking Buildbucket for the build status
[21:22:14.807] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:14.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:84:0) after 1m0s
[21:23:14.883] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:84:0)
[21:23:14.883] Timer tick, asking Buildbucket for the build status
[21:23:15.095] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:15.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:85:0) after 1m0s
[21:24:15.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:85:0)
[21:24:15.115] Timer tick, asking Buildbucket for the build status
[21:24:15.533] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:15.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:86:0) after 1m0s
[21:25:15.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:86:0)
[21:25:15.555] Timer tick, asking Buildbucket for the build status
[21:25:15.651] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:15.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:87:0) after 1m0s
[21:26:15.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:87:0)
[21:26:15.686] Timer tick, asking Buildbucket for the build status
[21:26:15.776] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:15.776] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:88:0) after 1m0s
[21:27:15.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:88:0)
[21:27:15.751] Timer tick, asking Buildbucket for the build status
[21:27:15.823] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:15.823] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:89:0) after 1m0s
[21:28:15.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:89:0)
[21:28:15.892] Timer tick, asking Buildbucket for the build status
[21:28:15.970] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:15.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:90:0) after 1m0s
[21:29:16.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:90:0)
[21:29:16.056] Timer tick, asking Buildbucket for the build status
[21:29:16.168] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:16.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:91:0) after 1m0s
[21:30:16.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:91:0)
[21:30:16.270] Timer tick, asking Buildbucket for the build status
[21:30:16.348] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:16.348] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:92:0) after 1m0s
[21:31:16.384] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:92:0)
[21:31:16.384] Timer tick, asking Buildbucket for the build status
[21:31:16.476] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:16.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:93:0) after 1m0s
[21:32:16.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:93:0)
[21:32:16.459] Timer tick, asking Buildbucket for the build status
[21:32:16.569] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:16.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:94:0) after 1m0s
[21:33:16.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:94:0)
[21:33:16.599] Timer tick, asking Buildbucket for the build status
[21:33:16.671] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:16.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:95:0) after 1m0s
[21:34:16.687] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:95:0)
[21:34:16.687] Timer tick, asking Buildbucket for the build status
[21:34:16.785] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:16.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:96:0) after 1m0s
[21:35:16.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:96:0)
[21:35:16.879] Timer tick, asking Buildbucket for the build status
[21:35:16.952] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:16.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:97:0) after 1m0s
[21:36:16.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:97:0)
[21:36:16.977] Timer tick, asking Buildbucket for the build status
[21:36:17.110] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:17.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:98:0) after 1m0s
[21:37:17.139] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:98:0)
[21:37:17.139] Timer tick, asking Buildbucket for the build status
[21:37:17.223] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:17.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:99:0) after 1m0s
[21:38:17.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:99:0)
[21:38:17.303] Timer tick, asking Buildbucket for the build status
[21:38:17.389] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:17.389] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:100:0) after 1m0s
[21:39:17.434] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:100:0)
[21:39:17.434] Timer tick, asking Buildbucket for the build status
[21:39:17.651] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:17.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:101:0) after 1m0s
[21:40:17.688] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:101:0)
[21:40:17.688] Timer tick, asking Buildbucket for the build status
[21:40:17.804] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:17.804] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:102:0) after 1m0s
[21:41:17.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:102:0)
[21:41:17.922] Timer tick, asking Buildbucket for the build status
[21:41:18.021] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:18.021] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:103:0) after 1m0s
[21:42:18.049] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:103:0)
[21:42:18.049] Timer tick, asking Buildbucket for the build status
[21:42:18.125] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:18.125] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:104:0) after 1m0s
[21:43:18.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:104:0)
[21:43:18.178] Timer tick, asking Buildbucket for the build status
[21:43:18.341] Build 8853207879935486128: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:18.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9018637941907528368:105:0) after 1m0s
[21:44:00.456] Received PubSub notification, asking Buildbucket for the build status
[21:44:00.723] Build 8853207879935486128: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[21:44:00.723] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1615326240140138",
"created_by": "project:chromium",
"created_ts": "1615320049308403",
"failure_reason": "BUILD_FAILURE",
"id": "8853207879935486128",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"69fc2acf3132a4a89829a3264e2582cbfd1a131c\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/1\"}, \"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\": \"69fc2acf3132a4a89829a3264e2582cbfd1a131c\", \"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-201-1nl3\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22926, \"got_angle_revision\": \"2d07b04d5a2635ccf4527eb644e8b0ed1fd92b4c\", \"got_dawn_revision\": \"7fe018c06578ff04d0e4ec2a0ada2c34a82ef6b0\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"69fc2acf3132a4a89829a3264e2582cbfd1a131c\", \"got_revision_cp\": \"refs/heads/master@{#861252}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"023914a27b634063766fee96f2e6763513f5b059\", \"got_v8_revision\": \"af560a8bf8228e4c3ec67af7a567370c75ff17bc\", \"got_v8_revision_cp\": \"refs/heads/9.1.81@{#1}\", \"got_webrtc_revision\": \"92d12707e00837a978485f731d72ef30cf19d2a2\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33402}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"69fc2acf3132a4a89829a3264e2582cbfd1a131c\", \"swarm_hashes_refs/heads/master(at){#861252}_without_patch\": {\"absl_hardening_tests\": \"502b60ed75e6fb14e038f35c981e5a59079b2aa4\", \"accessibility_unittests\": \"7165f0cad2f3c07ceb5b04e3f90921042da097c1\", \"angle_unittests\": \"7fabd9e92df098ff739cc1e5c2dc4317bd946691\", \"app_list_unittests\": \"8464d4a6d82aa8aaeaa2ba9792e29cbdf068a73b\", \"app_shell_unittests\": \"932d8df570146e80e1d491987445e79caf9011fd\", \"ash_unittests\": \"94b42c2bdec6ede2143dc936b555462e1a9d6112\", \"aura_unittests\": \"bf9f8d6124d5f2adcfc1f4864addf33f2d7f61b2\", \"base_unittests\": \"b107a31baedbd9ffdb0bf3ef9d8a03c144284932\", \"base_util_unittests\": \"0662b5be972e2b9a3d095b9d7e7e5f66f136a583\", \"blink_common_unittests\": \"676d479f4b06853af71e5ced1066aadfc5190686\", \"blink_fuzzer_unittests\": \"82cc58b732c8450e3c36fe5a553957383b1073b8\", \"blink_heap_unittests\": \"da80a15d6a7c25f90fd50cb5adef0c1ede9ac3a6\", \"blink_platform_unittests\": \"466bd6090c4bdb51774298c97d3f818846d3fb6e\", \"blink_unittests\": \"8386521d3a1b8ee4559e61a76d180ccb3a9c58ee\", \"boringssl_crypto_tests\": \"eba79d408bb8e67ed30f7ec0b1ceeb3e0a8796b7\", \"boringssl_ssl_tests\": \"a6c61478ae0129ac4bde2a8eae5f5a4099f498ae\", \"browser_tests\": \"0799a32f67d5d32f09ad8b239736a9425b741919\", \"capture_unittests\": \"5a1b3fcb19f5b100543172f9cb9faecd43411841\", \"cast_unittests\": \"adeaf695531f882d48f1b57de1e1105095f8c7eb\", \"cc_unittests\": \"a2e366f0044cb8adf61520e3a6e7f8b5134fefc7\", \"chrome_app_unittests\": \"8689de54cb0797dfe42c428a4cb0d00962ab377f\", \"chromedriver_unittests\": \"2e1af9580bece29b519be7ab622f947d8e3c682b\", \"chromeos_components_unittests\": \"0e929edf0391435e0d1887204e25169678de753b\", \"chromeos_unittests\": \"75f6082825171fd86c25a293d5c3a1d752e02ef1\", \"color_unittests\": \"a5303e71c2ad4e6b659e7d2e10f9440f3e55fd0f\", \"components_browsertests\": \"a58285c1668da998003b67d5ac2bbe8b3ff73546\", \"components_unittests\": \"930d74bea878297104dea2a3fe13e72c2d03abef\", \"compositor_unittests\": \"d7ea70d6ccecbfcf2efe8d3482ed2f750905454e\", \"content_browsertests\": \"2b0af511dd1db1de5059fcce9a7ea9454209c2bb\", \"content_unittests\": \"396715e0c745e4945966a9c1e735ad55fd803174\", \"crashpad_tests\": \"1bacb7dc8e393a6967a87468279073ac4d52c411\", \"crypto_unittests\": \"c120fa61041bed5843250309d00580986b28b0af\", \"dbus_unittests\": \"99605d43ebe5e8e80895cb98959f917263f5c795\", \"device_unittests\": \"9b57eac1452b96389d00cd414819dd51222298cf\", \"display_unittests\": \"4c924c77b72d5b8b4d49b8d0f455456457a6c482\", \"events_unittests\": \"0c6db331f8266bcc8dfe89775c5d6bd4ec764368\", \"exo_unittests\": \"6357579a727385d0bb7757d561d6eaddb0b52464\", \"extensions_browsertests\": \"e17149cf03a518f894392cf95ceb6d98b1f57184\", \"extensions_unittests\": \"a4fe2097d780937e0b844a3c38363a9fec36cde4\", \"filesystem_service_unittests\": \"fc10d8cc7ac52c5dfc46d20d32011523006ae52a\", \"gcm_unit_tests\": \"e16efa4e453320629b700cb8002ccc153dda3313\", \"gfx_unittests\": \"6a9e5cc42cd0c4de08831d19f98e684d28ab1d99\", \"gin_unittests\": \"824884da29adaed3dea4a427e438a12349b73b9b\", \"gl_unittests_ozone\": \"c0513773b14e8f46fee0331d3610f842e7f1cd41\", \"google_apis_unittests\": \"aa93f7e33605078a4cb9dc1c06026dfa6e8e0220\", \"gpu_unittests\": \"7ab5cdfc49acfd14e5dafd58d2e25732b47368ca\", \"gwp_asan_unittests\": \"ebca812c083544c970d2c913ff3e54614f839b62\", \"interactive_ui_tests\": \"dec4feb6597f41e953e6215c40596458d2027311\", \"ipc_tests\": \"0e93304479ef1c809fc6367b1e642461e69c36df\", \"jingle_unittests\": \"23152fb0ae091df019119da6d974d970948e59d4\", \"keyboard_unittests\": \"2b36e8244ba155408763c62f1f3489d372d46cb6\", \"latency_unittests\": \"9378603cda74cd065a32ecc626cf46fa501cc511\", \"libjingle_xmpp_unittests\": \"b4f3dca4325257469dbf7de09178253e28caa6a0\", \"liburlpattern_unittests\": \"24a35a7ea144f18207744150f3e2d04aab6ab260\", \"media_blink_unittests\": \"ec554a1bdb4c016250345d462b410794c7cd103f\", \"media_unittests\": \"053b0f9875078694d65a72538f832438ebfc8033\", \"message_center_unittests\": \"86deb44c4ad6a9b46048d3abd7d6a4745aed69c1\", \"midi_unittests\": \"cc6d4b0d3eeb130ce215ceeeb709816bf05291f0\", \"mojo_core_unittests\": \"e0936d9e692cfa28152c06e5677dc1bbb58a64f1\", \"mojo_unittests\": \"e4c724e18a2cc2ef0b955c5b2c608965d903d582\", \"nacl_helper_nonsfi_unittests\": \"59c8d1f60fd117c2f1e5d533a083124906311343\", \"nacl_loader_unittests\": \"10fde414c63679031d9876168ec280bf505364af\", \"native_theme_unittests\": \"b4ae1e5d2d7703fad3cdacc9b55870a7986d940f\", \"net_unittests\": \"7235d181d07ef2c3a2ec964c56a40b29dffbfb5d\", \"ozone_gl_unittests\": \"6d3eb11f693a0e891ba5556270ab21be6913e60e\", \"ozone_unittests\": \"d8ec9a700eb0ec8581254258ec38b4d782f9cce0\", \"ozone_x11_unittests\": \"504a267bfa04f4187823c15a2f47d8929d99da87\", \"pdf_unittests\": \"413aad3a6c11ffd8ddcf42e52930f88aaca68c28\", \"perfetto_unittests\": \"592197988336aa399a05018846b8560ac85bf08b\", \"ppapi_unittests\": \"ccbd071ceb32696d4ae7758460666689c66cf056\", \"printing_unittests\": \"f7e6dc4d01a1978c40d05749eba15e53290b6b52\", \"remoting_unittests\": \"b73a73d65e79493f8e61ebc33aca1375665d9482\", \"sandbox_linux_unittests\": \"af543626b5b7d1d53a2fa39521563d1137338e8c\", \"service_manager_unittests\": \"e3b4622941fd0b9beea472eef17a4ae182c9abb9\", \"services_unittests\": \"b3d28c39dfa7c0bc24c560c4d6f60635f577de08\", \"shell_dialogs_unittests\": \"911416e880a653eba5a70ad474b77df7877af6a4\", \"shell_encryption_unittests\": \"7a92a38e6678aa35719f7c751dc497b3ab4b1360\", \"skia_unittests\": \"a1d9f23e2217ec7629dfa11e2708da14dc1b4129\", \"snapshot_unittests\": \"1cc8949282a74f2f194a7073bef9da87b8c3ae96\", \"sql_unittests\": \"70998da1c4cae4682d636ef8602de22b20089fa3\", \"storage_unittests\": \"fd3619f52554a04788cee1041e6c431c65a9b7a7\", \"sync_integration_tests\": \"79bcb777291556a9920d6775482cc185a8348315\", \"traffic_annotation_auditor_unittests\": \"3d4d8abf2ee70d04df40bf5eea17955492404ef5\", \"ui_base_unittests\": \"1b5773559fbd46be701ee0459b347ccbc2d3d62b\", \"ui_chromeos_unittests\": \"9293b4c12b5440b38343302e4f370a9c795acef7\", \"ui_touch_selection_unittests\": \"e0497f8092b7ad38fc495da418d581d56bdd93bc\", \"unit_tests\": \"5b7498d6901db2836ffc2d6e9d348c926e7d7b6c\", \"url_unittests\": \"2a6ff8b57c3f8e385bf0b4004da5b90b4e5669c1\", \"usage_time_limit_unittests\": \"1ef474ea44204e8cb03f5da781ade0fafb668e91\", \"views_unittests\": \"6d14537c787cf006bd5d036720c5b9aef4752b94\", \"viz_unittests\": \"44b9be07046dee538d9e629a2e6e197f4662a5f6\", \"wayland_client_tests\": \"c806faa3df0a4d26f644994f3557d60e2b600388\", \"wm_unittests\": \"a15795c2f14d94828e7ef6be2dde598ba72e87a7\", \"wtf_unittests\": \"ee053d680829afd30a8987883b0f048d635028f4\", \"zlib_unittests\": \"522ff51e194715f2dc64a931f5f7ab510f95f9cc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_349e20fa0346c22afd9d85eafc166958d65f8d3eb174d2113a3f89c2e822dead_v2\", \"builder_3ee79eab7726d87d4f9bf92f4b58b9506b0a7a0d17f466f0c3d67bd50a4697d1_v2\", \"builder_4637b11d2a56187e25d14badb4fa154a12143e816e25cb34f5fe38c5c81ebb47_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-201-1nl3\"], \"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\": [\"5746-91ff3bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"1 Test Suite(s) failed.\\n\\n**app_list_unittests** failed because of:\\n\\n- All/AppsGridViewTest.MouseDragFlipPage/1\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615320053270726",
"status": "COMPLETED",
"status_changed_ts": "1615320053864415",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22926",
"builder:linux-chromeos-dbg",
"buildset:commit/git/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/69fc2acf3132a4a89829a3264e2582cbfd1a131c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9018637941907528368",
"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/8853207879935486128/+/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:52316574ccf49610",
"user_agent:luci-scheduler"
],
"updated_ts": "1615326240140628",
"url": "https://ci.chromium.org/b/8853207879935486128",
"utcnow_ts": "1615326240715505"
}
}
[21:44:00.723] Invocation finished in 1h43m12.67957424s with status FAILED