[20:27:16.078] New invocation is queued and will start shortly
[20:27:17.162] Starting the invocation (attempt 1)
[20:27:17.199] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:27:17.199] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:27:17.199] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9019179858546839856",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9019179858546839856",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"gitiles_ref:refs/heads/master"
]
}
[20:27:17.993] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1614803237308036",
"id": "8853749796595230016",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1614803237862655",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22851",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019179858546839856",
"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/8853749796595230016/+/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": "1614803237862760",
"url": "https://ci.chromium.org/b/8853749796595230016",
"utcnow_ts": "1614803237984748"
}
}
[20:27:17.993] Task URL: https://ci.chromium.org/b/8853749796595230016
[20:27:17.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:2:0) after 1m0s
[20:27:40.939] Received PubSub notification, asking Buildbucket for the build status
[20:27:41.013] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:18.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:2:0)
[20:28:18.191] Timer tick, asking Buildbucket for the build status
[20:28:18.280] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:28:18.280] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:4:0) after 1m0s
[20:29:18.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:4:0)
[20:29:18.284] Timer tick, asking Buildbucket for the build status
[20:29:18.379] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:29:18.379] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:5:0) after 1m0s
[20:30:18.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:5:0)
[20:30:18.421] Timer tick, asking Buildbucket for the build status
[20:30:18.532] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:30:18.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:6:0) after 1m0s
[20:31:18.549] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:6:0)
[20:31:18.549] Timer tick, asking Buildbucket for the build status
[20:31:19.016] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:31:19.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:7:0) after 1m0s
[20:32:19.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:7:0)
[20:32:19.046] Timer tick, asking Buildbucket for the build status
[20:32:19.134] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:32:19.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:8:0) after 1m0s
[20:33:19.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:8:0)
[20:33:19.210] Timer tick, asking Buildbucket for the build status
[20:33:19.450] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:33:19.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:9:0) after 1m0s
[20:34:19.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:9:0)
[20:34:19.455] Timer tick, asking Buildbucket for the build status
[20:34:20.793] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:34:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:10:0) after 1m0s
[20:35:20.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:10:0)
[20:35:20.906] Timer tick, asking Buildbucket for the build status
[20:35:21.887] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:35:21.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:11:0) after 1m0s
[20:36:21.972] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:11:0)
[20:36:21.972] Timer tick, asking Buildbucket for the build status
[20:36:22.062] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:36:22.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:12:0) after 1m0s
[20:37:22.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:12:0)
[20:37:22.082] Timer tick, asking Buildbucket for the build status
[20:37:22.240] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:37:22.240] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:13:0) after 1m0s
[20:38:22.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:13:0)
[20:38:22.257] Timer tick, asking Buildbucket for the build status
[20:38:22.333] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:38:22.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:14:0) after 1m0s
[20:39:22.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:14:0)
[20:39:22.352] Timer tick, asking Buildbucket for the build status
[20:39:22.437] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:39:22.437] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:15:0) after 1m0s
[20:40:22.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:15:0)
[20:40:22.458] Timer tick, asking Buildbucket for the build status
[20:40:22.519] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:40:22.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:16:0) after 1m0s
[20:41:22.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:16:0)
[20:41:22.595] Timer tick, asking Buildbucket for the build status
[20:41:22.801] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:41:22.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:17:0) after 1m0s
[20:42:22.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:17:0)
[20:42:22.839] Timer tick, asking Buildbucket for the build status
[20:42:22.910] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:42:22.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:18:0) after 1m0s
[20:43:22.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:18:0)
[20:43:22.968] Timer tick, asking Buildbucket for the build status
[20:43:23.041] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:43:23.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:19:0) after 1m0s
[20:44:23.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:19:0)
[20:44:23.096] Timer tick, asking Buildbucket for the build status
[20:44:23.259] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:44:23.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:20:0) after 1m0s
[20:45:23.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:20:0)
[20:45:23.271] Timer tick, asking Buildbucket for the build status
[20:45:23.378] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:45:23.378] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:21:0) after 1m0s
[20:46:23.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:21:0)
[20:46:23.565] Timer tick, asking Buildbucket for the build status
[20:46:23.663] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:46:23.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:22:0) after 1m0s
[20:47:23.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:22:0)
[20:47:23.822] Timer tick, asking Buildbucket for the build status
[20:47:23.911] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:47:23.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:23:0) after 1m0s
[20:48:24.309] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:23:0)
[20:48:24.309] Timer tick, asking Buildbucket for the build status
[20:48:24.441] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:48:24.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:24:0) after 1m0s
[20:49:24.494] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:24:0)
[20:49:24.494] Timer tick, asking Buildbucket for the build status
[20:49:24.708] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:49:24.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:25:0) after 1m0s
[20:50:24.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:25:0)
[20:50:24.853] Timer tick, asking Buildbucket for the build status
[20:50:28.633] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:50:28.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:26:0) after 1m0s
[20:51:28.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:26:0)
[20:51:28.751] Timer tick, asking Buildbucket for the build status
[20:51:28.855] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:51:28.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:27:0) after 1m0s
[20:52:28.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:27:0)
[20:52:28.837] Timer tick, asking Buildbucket for the build status
[20:52:29.149] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:52:29.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:28:0) after 1m0s
[20:53:29.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:28:0)
[20:53:29.203] Timer tick, asking Buildbucket for the build status
[20:53:29.349] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:53:29.349] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:29:0) after 1m0s
[20:54:29.380] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:29:0)
[20:54:29.380] Timer tick, asking Buildbucket for the build status
[20:54:29.460] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:54:29.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:30:0) after 1m0s
[20:55:29.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:30:0)
[20:55:29.459] Timer tick, asking Buildbucket for the build status
[20:55:29.527] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:55:29.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:31:0) after 1m0s
[20:56:29.559] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:31:0)
[20:56:29.559] Timer tick, asking Buildbucket for the build status
[20:56:29.675] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:56:29.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:32:0) after 1m0s
[20:57:29.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:32:0)
[20:57:29.698] Timer tick, asking Buildbucket for the build status
[20:57:29.786] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:57:29.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:33:0) after 1m0s
[20:58:29.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:33:0)
[20:58:29.823] Timer tick, asking Buildbucket for the build status
[20:58:29.953] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:58:29.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:34:0) after 1m0s
[20:59:30.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:34:0)
[20:59:30.027] Timer tick, asking Buildbucket for the build status
[20:59:30.146] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[20:59:30.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:35:0) after 1m0s
[21:00:30.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:35:0)
[21:00:30.167] Timer tick, asking Buildbucket for the build status
[21:00:30.326] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:00:30.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:36:0) after 1m0s
[21:01:30.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:36:0)
[21:01:30.349] Timer tick, asking Buildbucket for the build status
[21:01:30.422] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:01:30.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:37:0) after 1m0s
[21:02:30.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:37:0)
[21:02:30.457] Timer tick, asking Buildbucket for the build status
[21:02:30.550] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:02:30.550] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:38:0) after 1m0s
[21:03:30.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:38:0)
[21:03:30.596] Timer tick, asking Buildbucket for the build status
[21:03:30.662] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:03:30.662] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:39:0) after 1m0s
[21:04:30.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:39:0)
[21:04:30.780] Timer tick, asking Buildbucket for the build status
[21:04:30.870] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:04:30.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:40:0) after 1m0s
[21:05:30.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:40:0)
[21:05:30.948] Timer tick, asking Buildbucket for the build status
[21:05:31.043] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:05:31.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:41:0) after 1m0s
[21:06:31.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:41:0)
[21:06:31.070] Timer tick, asking Buildbucket for the build status
[21:06:31.168] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:06:31.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:42:0) after 1m0s
[21:07:31.267] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:42:0)
[21:07:31.267] Timer tick, asking Buildbucket for the build status
[21:07:31.346] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:07:31.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:43:0) after 1m0s
[21:08:32.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:43:0)
[21:08:32.430] Timer tick, asking Buildbucket for the build status
[21:08:32.502] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:08:32.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:44:0) after 1m0s
[21:09:32.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:44:0)
[21:09:32.528] Timer tick, asking Buildbucket for the build status
[21:09:32.615] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:09:32.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:45:0) after 1m0s
[21:10:32.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:45:0)
[21:10:32.679] Timer tick, asking Buildbucket for the build status
[21:10:33.211] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:10:33.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:46:0) after 1m0s
[21:11:33.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:46:0)
[21:11:33.220] Timer tick, asking Buildbucket for the build status
[21:11:33.302] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:11:33.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:47:0) after 1m0s
[21:12:33.405] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:47:0)
[21:12:33.405] Timer tick, asking Buildbucket for the build status
[21:12:33.565] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:12:33.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:48:0) after 1m0s
[21:13:33.660] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:48:0)
[21:13:33.660] Timer tick, asking Buildbucket for the build status
[21:13:33.752] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:13:33.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:49:0) after 1m0s
[21:14:33.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:49:0)
[21:14:33.831] Timer tick, asking Buildbucket for the build status
[21:14:35.015] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:14:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:50:0) after 1m0s
[21:15:35.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:50:0)
[21:15:35.028] Timer tick, asking Buildbucket for the build status
[21:15:35.127] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:15:35.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:51:0) after 1m0s
[21:16:35.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:51:0)
[21:16:35.196] Timer tick, asking Buildbucket for the build status
[21:16:36.316] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:16:36.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:52:0) after 1m0s
[21:17:36.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:52:0)
[21:17:36.341] Timer tick, asking Buildbucket for the build status
[21:17:36.421] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:17:36.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:53:0) after 1m0s
[21:18:36.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:53:0)
[21:18:36.440] Timer tick, asking Buildbucket for the build status
[21:18:36.956] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:18:36.956] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:54:0) after 1m0s
[21:19:37.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:54:0)
[21:19:37.014] Timer tick, asking Buildbucket for the build status
[21:19:37.108] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:19:37.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:55:0) after 1m0s
[21:20:37.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:55:0)
[21:20:37.211] Timer tick, asking Buildbucket for the build status
[21:20:37.516] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:20:37.516] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:56:0) after 1m0s
[21:21:37.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:56:0)
[21:21:37.576] Timer tick, asking Buildbucket for the build status
[21:21:37.697] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:21:37.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:57:0) after 1m0s
[21:22:37.770] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:57:0)
[21:22:37.770] Timer tick, asking Buildbucket for the build status
[21:22:37.857] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:22:37.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:58:0) after 1m0s
[21:23:37.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:58:0)
[21:23:37.922] Timer tick, asking Buildbucket for the build status
[21:23:38.012] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:23:38.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:59:0) after 1m0s
[21:24:38.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:59:0)
[21:24:38.133] Timer tick, asking Buildbucket for the build status
[21:24:38.206] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:24:38.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:60:0) after 1m0s
[21:25:38.265] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:60:0)
[21:25:38.265] Timer tick, asking Buildbucket for the build status
[21:25:38.527] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:25:38.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:61:0) after 1m0s
[21:26:38.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:61:0)
[21:26:38.576] Timer tick, asking Buildbucket for the build status
[21:26:38.768] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:26:38.768] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:62:0) after 1m0s
[21:27:38.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:62:0)
[21:27:38.764] Timer tick, asking Buildbucket for the build status
[21:27:39.064] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:27:39.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:63:0) after 1m0s
[21:28:39.090] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:63:0)
[21:28:39.090] Timer tick, asking Buildbucket for the build status
[21:28:39.178] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:28:39.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:64:0) after 1m0s
[21:29:39.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:64:0)
[21:29:39.203] Timer tick, asking Buildbucket for the build status
[21:29:39.294] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:29:39.294] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:65:0) after 1m0s
[21:30:39.316] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:65:0)
[21:30:39.316] Timer tick, asking Buildbucket for the build status
[21:30:39.730] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:30:39.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:66:0) after 1m0s
[21:31:39.760] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:66:0)
[21:31:39.760] Timer tick, asking Buildbucket for the build status
[21:31:40.179] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:31:40.179] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:67:0) after 1m0s
[21:32:40.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:67:0)
[21:32:40.315] Timer tick, asking Buildbucket for the build status
[21:32:40.422] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:32:40.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:68:0) after 1m0s
[21:33:40.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:68:0)
[21:33:40.452] Timer tick, asking Buildbucket for the build status
[21:33:40.598] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:33:40.598] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:69:0) after 1m0s
[21:34:40.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:69:0)
[21:34:40.684] Timer tick, asking Buildbucket for the build status
[21:34:40.763] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:34:40.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:70:0) after 1m0s
[21:35:40.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:70:0)
[21:35:40.905] Timer tick, asking Buildbucket for the build status
[21:35:41.004] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:35:41.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:71:0) after 1m0s
[21:36:41.149] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:71:0)
[21:36:41.149] Timer tick, asking Buildbucket for the build status
[21:36:41.581] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:36:41.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:72:0) after 1m0s
[21:37:41.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:72:0)
[21:37:41.621] Timer tick, asking Buildbucket for the build status
[21:37:41.723] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:37:41.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:73:0) after 1m0s
[21:38:41.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:73:0)
[21:38:41.785] Timer tick, asking Buildbucket for the build status
[21:38:41.861] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:38:41.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:74:0) after 1m0s
[21:39:41.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:74:0)
[21:39:41.878] Timer tick, asking Buildbucket for the build status
[21:39:41.966] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:39:41.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:75:0) after 1m0s
[21:40:42.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:75:0)
[21:40:42.007] Timer tick, asking Buildbucket for the build status
[21:40:42.191] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:40:42.191] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:76:0) after 1m0s
[21:41:42.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:76:0)
[21:41:42.220] Timer tick, asking Buildbucket for the build status
[21:41:42.341] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:41:42.341] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:77:0) after 1m0s
[21:42:42.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:77:0)
[21:42:42.435] Timer tick, asking Buildbucket for the build status
[21:42:42.554] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:42:42.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:78:0) after 1m0s
[21:43:42.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:78:0)
[21:43:42.565] Timer tick, asking Buildbucket for the build status
[21:43:42.717] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:43:42.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:79:0) after 1m0s
[21:44:42.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:79:0)
[21:44:42.752] Timer tick, asking Buildbucket for the build status
[21:44:43.111] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:44:43.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:80:0) after 1m0s
[21:45:43.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:80:0)
[21:45:43.681] Timer tick, asking Buildbucket for the build status
[21:45:43.819] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:45:43.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:81:0) after 1m0s
[21:46:43.950] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:81:0)
[21:46:43.950] Timer tick, asking Buildbucket for the build status
[21:46:44.047] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:46:44.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:82:0) after 1m0s
[21:47:44.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:82:0)
[21:47:44.157] Timer tick, asking Buildbucket for the build status
[21:47:44.245] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:47:44.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:83:0) after 1m0s
[21:48:44.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:83:0)
[21:48:44.385] Timer tick, asking Buildbucket for the build status
[21:48:44.462] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:48:44.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:84:0) after 1m0s
[21:49:44.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:84:0)
[21:49:44.560] Timer tick, asking Buildbucket for the build status
[21:49:44.716] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:49:44.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:85:0) after 1m0s
[21:50:44.736] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:85:0)
[21:50:44.736] Timer tick, asking Buildbucket for the build status
[21:50:44.890] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:50:44.890] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:86:0) after 1m0s
[21:51:44.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:86:0)
[21:51:44.970] Timer tick, asking Buildbucket for the build status
[21:51:48.836] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:51:48.836] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:87:0) after 1m0s
[21:52:48.838] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:87:0)
[21:52:48.838] Timer tick, asking Buildbucket for the build status
[21:52:48.934] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:52:48.934] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:88:0) after 1m0s
[21:53:48.954] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:88:0)
[21:53:48.954] Timer tick, asking Buildbucket for the build status
[21:53:49.216] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:53:49.216] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:89:0) after 1m0s
[21:54:49.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:89:0)
[21:54:49.304] Timer tick, asking Buildbucket for the build status
[21:54:49.459] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:54:49.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:90:0) after 1m0s
[21:55:49.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:90:0)
[21:55:49.527] Timer tick, asking Buildbucket for the build status
[21:55:49.665] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:55:49.665] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:91:0) after 1m0s
[21:56:49.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:91:0)
[21:56:49.756] Timer tick, asking Buildbucket for the build status
[21:56:50.314] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:56:50.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:92:0) after 1m0s
[21:57:50.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:92:0)
[21:57:50.609] Timer tick, asking Buildbucket for the build status
[21:57:50.723] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:57:50.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:93:0) after 1m0s
[21:58:51.012] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:93:0)
[21:58:51.012] Timer tick, asking Buildbucket for the build status
[21:58:51.694] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:58:51.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:94:0) after 1m0s
[21:59:51.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:94:0)
[21:59:51.784] Timer tick, asking Buildbucket for the build status
[21:59:51.915] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[21:59:51.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:95:0) after 1m0s
[22:00:52.020] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:95:0)
[22:00:52.020] Timer tick, asking Buildbucket for the build status
[22:00:52.223] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:52.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:96:0) after 1m0s
[22:01:52.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:96:0)
[22:01:52.403] Timer tick, asking Buildbucket for the build status
[22:01:52.499] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:52.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:97:0) after 1m0s
[22:02:52.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:97:0)
[22:02:52.598] Timer tick, asking Buildbucket for the build status
[22:02:52.695] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:52.695] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:98:0) after 1m0s
[22:03:52.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:98:0)
[22:03:52.793] Timer tick, asking Buildbucket for the build status
[22:03:52.990] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:52.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:99:0) after 1m0s
[22:04:53.506] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:99:0)
[22:04:53.506] Timer tick, asking Buildbucket for the build status
[22:04:53.683] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:53.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:100:0) after 1m0s
[22:05:54.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:100:0)
[22:05:54.015] Timer tick, asking Buildbucket for the build status
[22:05:54.347] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:54.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:101:0) after 1m0s
[22:06:54.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:101:0)
[22:06:54.350] Timer tick, asking Buildbucket for the build status
[22:06:54.436] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:54.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:102:0) after 1m0s
[22:07:54.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:102:0)
[22:07:54.619] Timer tick, asking Buildbucket for the build status
[22:07:54.745] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:54.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:103:0) after 1m0s
[22:08:54.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:103:0)
[22:08:54.884] Timer tick, asking Buildbucket for the build status
[22:08:55.035] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:55.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:104:0) after 1m0s
[22:09:55.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:104:0)
[22:09:55.070] Timer tick, asking Buildbucket for the build status
[22:09:55.540] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:55.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:105:0) after 1m0s
[22:10:55.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:105:0)
[22:10:55.558] Timer tick, asking Buildbucket for the build status
[22:10:56.517] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:56.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:106:0) after 1m0s
[22:11:56.560] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:106:0)
[22:11:56.560] Timer tick, asking Buildbucket for the build status
[22:11:56.659] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:56.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:107:0) after 1m0s
[22:12:56.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:107:0)
[22:12:56.700] Timer tick, asking Buildbucket for the build status
[22:12:56.786] Build 8853749796595230016: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:56.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9019179858546839856:108:0) after 1m0s
[22:13:31.693] Received PubSub notification, asking Buildbucket for the build status
[22:13:31.803] Build 8853749796595230016: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[22:13:31.803] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1614809611389882",
"created_by": "project:chromium",
"created_ts": "1614803237308036",
"failure_reason": "BUILD_FAILURE",
"id": "8853749796595230016",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"2 Test Suite(s) failed.\\n\\n**chromeos_unittests** failed because of:\\n\\n- NetworkConnectTest.ConnectToCellularNetwork_OutOfCredits\\n\\n**browser_tests** failed because of:\\n\\n- All/AppLaunchHandlerSystemWebAppsBrowserTest.LaunchSWA/_Default\"}, \"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\": \"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\", \"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-193-vl1d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22851, \"got_angle_revision\": \"1de8b5a697e731c03083bda16b2df67c1d7a4c47\", \"got_dawn_revision\": \"9b5f442c78cb642b18bc4f18ab672f1b4426c934\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\", \"got_revision_cp\": \"refs/heads/master@{#859509}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"106e01583a3ac2fb950777390dde2dcc31a8f161\", \"got_v8_revision\": \"1bf9a25b8165c205ba4ed305e8e84bc4a8e54fbc\", \"got_v8_revision_cp\": \"refs/heads/9.1.31@{#1}\", \"got_webrtc_revision\": \"07d83c8a9af02a0afc473503f75f150f23e3e0ff\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33366}\", \"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\": \"c4e1397c9ba212b6be39e48cc80d1563dbd5a014\", \"swarm_hashes_refs/heads/master(at){#859509}_without_patch\": {\"absl_hardening_tests\": \"20d2acaba2694a189ff196306faf8cb291124ab3\", \"accessibility_unittests\": \"6bb11a9af4042570b66f37a90faa417ba1567c3c\", \"angle_unittests\": \"6e6a565230975867b056a55bb968dfd24a88c8de\", \"app_list_unittests\": \"5de969bdc6a571820c55a8f5523ea402f28a221c\", \"app_shell_unittests\": \"c7debafaeedd408c081174875af48ffc4a7c52e1\", \"ash_unittests\": \"499ef590c77a809a2b904fd43723af9f272843f4\", \"aura_unittests\": \"f7ea9e630c75a9cc3c765f73e99fa38ab32a1231\", \"base_unittests\": \"323797dddf6d7fd9912c8c5c22b33ff50d331170\", \"base_util_unittests\": \"dc065db5907fb3cdfb50a626dae20d2e71ac9d96\", \"blink_common_unittests\": \"2dee4ef97b95b0a700005f31953a794de8d586ea\", \"blink_fuzzer_unittests\": \"4c3a606ee060d5144a17474947ef627fee137c36\", \"blink_heap_unittests\": \"0aef053e61836d0f88e2ff62f2256a51f940d04c\", \"blink_platform_unittests\": \"6ec0a7cb68c5e61b03c50968249b1c34152b82d8\", \"blink_unittests\": \"52abe86581722ef77a2ea39605ed5d024c7a7320\", \"boringssl_crypto_tests\": \"a1e5a92fe29eda8a6c4038b777a852c9da158b68\", \"boringssl_ssl_tests\": \"54b931b3549d4e237ae8ef27ddee90872ab4d3f7\", \"browser_tests\": \"e369322967b649bb0d664541f99aa7f4a5a5ccd9\", \"capture_unittests\": \"ff36f56356ee4017c7f8ccd0a204793507067c02\", \"cast_unittests\": \"427ac229195dc64b3b37a41dc292f1794072a0fb\", \"cc_unittests\": \"830854d33556f7c34f71c7b3d771d02895c7ae23\", \"chrome_app_unittests\": \"6733bcba117b8307e9b5d678992062b45d9bcab0\", \"chromedriver_unittests\": \"de099abb06d5b092cb1f0aaefb35418f137d2860\", \"chromeos_components_unittests\": \"825bb11e35b42733d196b9e7add69c8628b2184d\", \"chromeos_unittests\": \"41d30e0ea28fb622cc226d7234ae1e08d6c1d782\", \"color_unittests\": \"6af025d6417d277d519004af5516bf185b72abdf\", \"components_browsertests\": \"48a787de3aac29c8752a7bcda1a1679efb3113cc\", \"components_unittests\": \"4d51cac8c5499011e78f98e2e2b9f3ab20753459\", \"compositor_unittests\": \"95e9fba3d39b0fea2af23c3f85df3e1ec4b314c3\", \"content_browsertests\": \"e837692441f0b72ae8a9f104bcd69983cb091300\", \"content_unittests\": \"c89be911f18d7d142ef8c085fd06f6a88967b1ca\", \"crashpad_tests\": \"68c34b47a950babe7996d795020471bb2fa69038\", \"crypto_unittests\": \"122ac3c814444a2a98cd01dc9e9fc897cb285044\", \"dbus_unittests\": \"9a5835f87e25042625c63ab45f21eb7e6dc081bc\", \"device_unittests\": \"0d5cae24fd88220fd66e39e692b4921685469589\", \"display_unittests\": \"029857b5e27440435610c306128ed0b89c2d323c\", \"events_unittests\": \"0082a4f114857a621014c5f026ca70775a3655e6\", \"exo_unittests\": \"848647f49317ea8709e6095718e9f8e76f09dc73\", \"extensions_browsertests\": \"4e0c6f8dbc436f0c9a619f258face52ebad91ca2\", \"extensions_unittests\": \"388fb3dc65a13099930e01c80be0fc0b32c6730c\", \"filesystem_service_unittests\": \"7d67a4c8209cc83e04d82419e855a7f0a14599a4\", \"gcm_unit_tests\": \"fd217e533ff2259ff64bb48a29ca707155beabc2\", \"gfx_unittests\": \"5177a6a3928daaa98d563decd4f6fb21d4eb2d05\", \"gin_unittests\": \"b024e41b3bb26e3cfaea67ebdfa0382c8da1d0ca\", \"gl_unittests_ozone\": \"59ceeea388fc325d4f0e9350c9e3b2be26b54618\", \"google_apis_unittests\": \"dde42f2c5f894631ef83798727b8f21daebc1f7c\", \"gpu_unittests\": \"099b95c41982e20ed6dc963cc14e67d43af25d4e\", \"gwp_asan_unittests\": \"79d822dbc62570fe540a14bedb8ff23a5ebd5a50\", \"interactive_ui_tests\": \"ad3af4bee9bf89fbb2dcefa4738fe9d5821d5ffd\", \"ipc_tests\": \"26723a4a4912466120d748c494020458b80c681c\", \"jingle_unittests\": \"e5abf5d905a098c656905ff13bc41ffa2691a510\", \"keyboard_unittests\": \"66aced2cc304aeeb973ef5a1b7c9e05103269fb1\", \"latency_unittests\": \"ab70bb2eb63853114cb713aaea01c54edb614cee\", \"libjingle_xmpp_unittests\": \"165bc82320e65b8e66d27fabceba12d8bc7a0a7c\", \"liburlpattern_unittests\": \"71bbd75b5de503e19574daf702a06ff5df05708d\", \"media_blink_unittests\": \"3c2d8ef2ccf988ba1ec369e06c7b4a446443448f\", \"media_unittests\": \"11e80f4cdc4098feb6b74727dc693c0467e41c80\", \"message_center_unittests\": \"705aecd69f629692641f7f393b842a59a488b5f9\", \"midi_unittests\": \"dabaaea62e57c8278e078e3083f8771c03fff050\", \"mojo_core_unittests\": \"17f8da57a5073c4e0398004efcd434e261c4ccc6\", \"mojo_unittests\": \"d5463da2216db56f391fe3c86bf87dc0ad5ecb5b\", \"nacl_helper_nonsfi_unittests\": \"8e03e4b84da8a660c27710141f92b110061a3fe3\", \"nacl_loader_unittests\": \"af04233254f7ffd1d608b7082da6e64a60dec990\", \"native_theme_unittests\": \"e454aee9348742f597b9417425f06de3d88fcd8a\", \"net_unittests\": \"3fd780c33faf5376555ff9b6fc276842b2c6feae\", \"ozone_gl_unittests\": \"ad0051744931b7a7d7b6af592e5604026c1c222a\", \"ozone_unittests\": \"0b41e89d8072e90b28736610bcef73ce18834cfe\", \"ozone_x11_unittests\": \"61d42d3152b21a08ea62604bd4bed3c1fbcabf29\", \"pdf_unittests\": \"86e125143b7a4f093be77e5f39c2092b45836cca\", \"perfetto_unittests\": \"edd0ba4ddaf5414608d99bada8ff513a4fe353c4\", \"ppapi_unittests\": \"1954f1dc5fe86205c9e566b9f67f7b15d0ddeef5\", \"printing_unittests\": \"14bbf9883fb94123963f6f2e6d9be2d7faec7329\", \"remoting_unittests\": \"12e6cadf14ca28929f398d7e69da8da5ea6eb06a\", \"sandbox_linux_unittests\": \"46d9a1207c32aae432e1817f73cd21e37c9cf33f\", \"service_manager_unittests\": \"eb4ccf3f84f7d05208b5e023f92badf513245645\", \"services_unittests\": \"ca19d62be996eb472fc451bad5f312c8153409de\", \"shell_dialogs_unittests\": \"dc2fa9c8c1f888732289e4f29bce96f4977ec518\", \"shell_encryption_unittests\": \"35919f27616929bcca2d95d8d9ad4171d1d84c8f\", \"skia_unittests\": \"e6a1af643c6817939becb06d590816e40289a98c\", \"snapshot_unittests\": \"31ee505b312c727741a4ea1d4314e9b92116275f\", \"sql_unittests\": \"40bf8fec4d92151a88a2f44f4643498009adf959\", \"storage_unittests\": \"e504e89b02d16eb4a59ab9a32e61fafa843790d3\", \"sync_integration_tests\": \"b69e9525edca38546b7468457d7bd6a802acfb74\", \"traffic_annotation_auditor_unittests\": \"9b4a3d439423a09eb0243f58ffed23dacbcc914f\", \"ui_base_unittests\": \"fada8352f3c13e05bf3a2cf0352c9aa30e91c1bb\", \"ui_chromeos_unittests\": \"873276c892afb2b3094ddf918b581de98e420bc2\", \"ui_touch_selection_unittests\": \"982723486945db54a0f389a64ce97e02fac909d0\", \"unit_tests\": \"9afdda9d357f19ba8522d090553ecfecd2f969cb\", \"url_unittests\": \"e2a055ccbb1d7ef545253c9935ad1bd9f5ee2e60\", \"usage_time_limit_unittests\": \"d33f93cb8aa36bb5c09382a72e8012bce734ba5d\", \"views_unittests\": \"81dc94651bc28a58947df8d2f7b7462a9550eda5\", \"viz_unittests\": \"08825d8464e23b55944ca860ffb4ae4ef72ce7bf\", \"wayland_client_tests\": \"06830a1e7206c40f8665bdc0e30acccaed1cf235\", \"wm_unittests\": \"8478704ff7fe14b53835d72195754798567c0153\", \"wtf_unittests\": \"8b2a34ab2228803971453c1065e477f5b5e4e023\", \"zlib_unittests\": \"05bce34ff055820ec1a600725989207dbb705805\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_4a782824ba39c0c6a32b2128ebb0687e83cb58dc0cbed64e2911b02f7893cfe6_v2\", \"builder_71ab4550ecc1db180544ee9bd5ebac58222d39ccc6e59d756fcde46903b3067c_v2\", \"builder_f11fafa89e130b21aaaf89babe10260b305cabf64cf9dbedf786af2782bba9d2_v2\", \"builder_fe96da9c6a19fa2fc3ad0c2b7020b7cb68e4a92161f4cd6cb7dc1d1e2d5af5dc_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-193-vl1d\"], \"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\": [\"5725-1a0d85e\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}, \"ui\": {\"info\": \"2 Test Suite(s) failed.\\n\\n**chromeos_unittests** failed because of:\\n\\n- NetworkConnectTest.ConnectToCellularNetwork_OutOfCredits\\n\\n**browser_tests** failed because of:\\n\\n- All/AppLaunchHandlerSystemWebAppsBrowserTest.LaunchSWA/_Default\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1614803260273148",
"status": "COMPLETED",
"status_changed_ts": "1614803260668117",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22851",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c4e1397c9ba212b6be39e48cc80d1563dbd5a014",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9019179858546839856",
"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/8853749796595230016/+/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:5212978616b04610",
"user_agent:luci-scheduler"
],
"updated_ts": "1614809611390189",
"url": "https://ci.chromium.org/b/8853749796595230016",
"utcnow_ts": "1614809611793379"
}
}
[22:13:31.803] Invocation finished in 1h46m15.740946485s with status FAILED