[22:32:39.062] New invocation is queued and will start shortly
[22:32:40.385] Starting the invocation (attempt 1)
[22:32:40.424] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:32:40.425] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:32:40.425] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9026963309238706048",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dea9aceb679834381d3fcf72397acfc4d06e8226\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9026963309238706048",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/dea9aceb679834381d3fcf72397acfc4d06e8226",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dea9aceb679834381d3fcf72397acfc4d06e8226",
"gitiles_ref:refs/heads/master"
]
}
[22:32:42.405] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607380360689692",
"id": "8861533246868436576",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dea9aceb679834381d3fcf72397acfc4d06e8226\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607380362025264",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21648",
"builder:linux-chromeos-dbg",
"buildset:commit/git/dea9aceb679834381d3fcf72397acfc4d06e8226",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dea9aceb679834381d3fcf72397acfc4d06e8226",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026963309238706048",
"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/8861533246868436576/+/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": "1607380362025450",
"url": "https://ci.chromium.org/b/8861533246868436576",
"utcnow_ts": "1607380362388950"
}
}
[22:32:42.405] Task URL: https://ci.chromium.org/b/8861533246868436576
[22:32:42.405] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:2:0) after 1m0s
[22:32:43.757] Received PubSub notification, asking Buildbucket for the build status
[22:32:43.836] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:42.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:2:0)
[22:33:42.469] Timer tick, asking Buildbucket for the build status
[22:33:42.752] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:42.752] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:4:0) after 1m0s
[22:34:42.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:4:0)
[22:34:42.788] Timer tick, asking Buildbucket for the build status
[22:34:43.107] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:43.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:5:0) after 1m0s
[22:35:43.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:5:0)
[22:35:43.122] Timer tick, asking Buildbucket for the build status
[22:35:43.217] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:43.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:6:0) after 1m0s
[22:36:43.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:6:0)
[22:36:43.260] Timer tick, asking Buildbucket for the build status
[22:36:43.612] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:43.612] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:7:0) after 1m0s
[22:37:43.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:7:0)
[22:37:43.702] Timer tick, asking Buildbucket for the build status
[22:37:43.797] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:8:0) after 1m0s
[22:38:43.806] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:8:0)
[22:38:43.806] Timer tick, asking Buildbucket for the build status
[22:38:43.906] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:43.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:9:0) after 1m0s
[22:39:44.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:9:0)
[22:39:44.083] Timer tick, asking Buildbucket for the build status
[22:39:44.140] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:44.140] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:10:0) after 1m0s
[22:40:44.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:10:0)
[22:40:44.228] Timer tick, asking Buildbucket for the build status
[22:40:44.297] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:44.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:11:0) after 1m0s
[22:41:44.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:11:0)
[22:41:44.386] Timer tick, asking Buildbucket for the build status
[22:41:44.452] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:44.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:12:0) after 1m0s
[22:42:44.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:12:0)
[22:42:44.574] Timer tick, asking Buildbucket for the build status
[22:42:44.681] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:44.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:13:0) after 1m0s
[22:43:44.822] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:13:0)
[22:43:44.822] Timer tick, asking Buildbucket for the build status
[22:43:45.239] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:45.239] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:14:0) after 1m0s
[22:44:45.345] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:14:0)
[22:44:45.345] Timer tick, asking Buildbucket for the build status
[22:44:45.408] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:45.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:15:0) after 1m0s
[22:45:45.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:15:0)
[22:45:45.385] Timer tick, asking Buildbucket for the build status
[22:45:45.444] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:45.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:16:0) after 1m0s
[22:46:45.601] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:16:0)
[22:46:45.601] Timer tick, asking Buildbucket for the build status
[22:46:45.835] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:45.835] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:17:0) after 1m0s
[22:47:45.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:17:0)
[22:47:45.889] Timer tick, asking Buildbucket for the build status
[22:47:46.004] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:46.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:18:0) after 1m0s
[22:48:46.152] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:18:0)
[22:48:46.152] Timer tick, asking Buildbucket for the build status
[22:48:46.213] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:46.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:19:0) after 1m0s
[22:49:46.261] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:19:0)
[22:49:46.261] Timer tick, asking Buildbucket for the build status
[22:49:46.330] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:46.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:20:0) after 1m0s
[22:50:46.499] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:20:0)
[22:50:46.499] Timer tick, asking Buildbucket for the build status
[22:50:46.661] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:46.661] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:21:0) after 1m0s
[22:51:46.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:21:0)
[22:51:46.830] Timer tick, asking Buildbucket for the build status
[22:51:47.015] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:47.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:22:0) after 1m0s
[22:52:47.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:22:0)
[22:52:47.164] Timer tick, asking Buildbucket for the build status
[22:52:47.605] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:47.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:23:0) after 1m0s
[22:53:47.763] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:23:0)
[22:53:47.763] Timer tick, asking Buildbucket for the build status
[22:53:47.846] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:47.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:24:0) after 1m0s
[22:54:48.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:24:0)
[22:54:48.035] Timer tick, asking Buildbucket for the build status
[22:54:48.715] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:48.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:25:0) after 1m0s
[22:55:48.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:25:0)
[22:55:48.746] Timer tick, asking Buildbucket for the build status
[22:55:48.846] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:48.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:26:0) after 1m0s
[22:56:48.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:26:0)
[22:56:48.927] Timer tick, asking Buildbucket for the build status
[22:56:48.985] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:48.985] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:27:0) after 1m0s
[22:57:49.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:27:0)
[22:57:49.048] Timer tick, asking Buildbucket for the build status
[22:57:49.151] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:49.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:28:0) after 1m0s
[22:58:49.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:28:0)
[22:58:49.185] Timer tick, asking Buildbucket for the build status
[22:58:49.285] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:49.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:29:0) after 1m0s
[22:59:49.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:29:0)
[22:59:49.276] Timer tick, asking Buildbucket for the build status
[22:59:49.347] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:49.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:30:0) after 1m0s
[23:00:49.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:30:0)
[23:00:49.370] Timer tick, asking Buildbucket for the build status
[23:00:49.596] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:49.596] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:31:0) after 1m0s
[23:01:49.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:31:0)
[23:01:49.617] Timer tick, asking Buildbucket for the build status
[23:01:49.682] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:49.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:32:0) after 1m0s
[23:02:49.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:32:0)
[23:02:49.793] Timer tick, asking Buildbucket for the build status
[23:02:50.059] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:50.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:33:0) after 1m0s
[23:03:50.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:33:0)
[23:03:50.097] Timer tick, asking Buildbucket for the build status
[23:03:50.192] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:50.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:34:0) after 1m0s
[23:04:50.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:34:0)
[23:04:50.296] Timer tick, asking Buildbucket for the build status
[23:04:50.610] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:50.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:35:0) after 1m0s
[23:05:50.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:35:0)
[23:05:50.639] Timer tick, asking Buildbucket for the build status
[23:05:51.077] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:51.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:36:0) after 1m0s
[23:06:51.097] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:36:0)
[23:06:51.097] Timer tick, asking Buildbucket for the build status
[23:06:51.176] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:51.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:37:0) after 1m0s
[23:07:51.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:37:0)
[23:07:51.212] Timer tick, asking Buildbucket for the build status
[23:07:51.364] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:51.364] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:38:0) after 1m0s
[23:08:51.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:38:0)
[23:08:51.385] Timer tick, asking Buildbucket for the build status
[23:08:51.438] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:51.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:39:0) after 1m0s
[23:09:51.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:39:0)
[23:09:51.463] Timer tick, asking Buildbucket for the build status
[23:09:51.527] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:51.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:40:0) after 1m0s
[23:10:51.593] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:40:0)
[23:10:51.593] Timer tick, asking Buildbucket for the build status
[23:10:51.654] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:51.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:41:0) after 1m0s
[23:11:51.683] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:41:0)
[23:11:51.683] Timer tick, asking Buildbucket for the build status
[23:11:51.797] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:51.797] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:42:0) after 1m0s
[23:12:51.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:42:0)
[23:12:51.823] Timer tick, asking Buildbucket for the build status
[23:12:51.909] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:51.909] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:43:0) after 1m0s
[23:13:52.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:43:0)
[23:13:52.019] Timer tick, asking Buildbucket for the build status
[23:13:52.627] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:52.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:44:0) after 1m0s
[23:14:52.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:44:0)
[23:14:52.664] Timer tick, asking Buildbucket for the build status
[23:14:53.160] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:53.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:45:0) after 1m0s
[23:15:53.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:45:0)
[23:15:53.263] Timer tick, asking Buildbucket for the build status
[23:15:53.329] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:53.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:46:0) after 1m0s
[23:16:53.376] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:46:0)
[23:16:53.376] Timer tick, asking Buildbucket for the build status
[23:17:01.970] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:01.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:47:0) after 1m0s
[23:18:02.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:47:0)
[23:18:02.023] Timer tick, asking Buildbucket for the build status
[23:18:02.541] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:02.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:48:0) after 1m0s
[23:19:02.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:48:0)
[23:19:02.567] Timer tick, asking Buildbucket for the build status
[23:19:02.633] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:02.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:49:0) after 1m0s
[23:20:02.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:49:0)
[23:20:02.694] Timer tick, asking Buildbucket for the build status
[23:20:03.518] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:03.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:50:0) after 1m0s
[23:21:03.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:50:0)
[23:21:03.602] Timer tick, asking Buildbucket for the build status
[23:21:03.664] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:03.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:51:0) after 1m0s
[23:22:03.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:51:0)
[23:22:03.697] Timer tick, asking Buildbucket for the build status
[23:22:03.893] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:03.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:52:0) after 1m0s
[23:23:04.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:52:0)
[23:23:04.058] Timer tick, asking Buildbucket for the build status
[23:23:04.484] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:04.484] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:53:0) after 1m0s
[23:24:04.579] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:53:0)
[23:24:04.579] Timer tick, asking Buildbucket for the build status
[23:24:04.720] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:04.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:54:0) after 1m0s
[23:25:04.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:54:0)
[23:25:04.781] Timer tick, asking Buildbucket for the build status
[23:25:04.876] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:04.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:55:0) after 1m0s
[23:26:04.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:55:0)
[23:26:04.919] Timer tick, asking Buildbucket for the build status
[23:26:05.048] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:05.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:56:0) after 1m0s
[23:27:05.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:56:0)
[23:27:05.162] Timer tick, asking Buildbucket for the build status
[23:27:05.295] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:05.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:57:0) after 1m0s
[23:28:05.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:57:0)
[23:28:05.371] Timer tick, asking Buildbucket for the build status
[23:28:05.498] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:05.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:58:0) after 1m0s
[23:29:05.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:58:0)
[23:29:05.585] Timer tick, asking Buildbucket for the build status
[23:29:05.774] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:05.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:59:0) after 1m0s
[23:30:05.807] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:59:0)
[23:30:05.807] Timer tick, asking Buildbucket for the build status
[23:30:05.951] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:05.951] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:60:0) after 1m0s
[23:31:06.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:60:0)
[23:31:06.349] Timer tick, asking Buildbucket for the build status
[23:31:06.805] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:06.805] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:61:0) after 1m0s
[23:32:06.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:61:0)
[23:32:06.796] Timer tick, asking Buildbucket for the build status
[23:32:06.917] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:06.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:62:0) after 1m0s
[23:33:07.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:62:0)
[23:33:07.017] Timer tick, asking Buildbucket for the build status
[23:33:07.174] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:07.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:63:0) after 1m0s
[23:34:07.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:63:0)
[23:34:07.301] Timer tick, asking Buildbucket for the build status
[23:34:08.108] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:08.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:64:0) after 1m0s
[23:35:08.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:64:0)
[23:35:08.225] Timer tick, asking Buildbucket for the build status
[23:35:08.439] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:08.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:65:0) after 1m0s
[23:36:08.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:65:0)
[23:36:08.475] Timer tick, asking Buildbucket for the build status
[23:36:08.549] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:08.549] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:66:0) after 1m0s
[23:37:08.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:66:0)
[23:37:08.605] Timer tick, asking Buildbucket for the build status
[23:37:09.245] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:09.245] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:67:0) after 1m0s
[23:38:09.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:67:0)
[23:38:09.398] Timer tick, asking Buildbucket for the build status
[23:38:09.675] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:09.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:68:0) after 1m0s
[23:39:09.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:68:0)
[23:39:09.769] Timer tick, asking Buildbucket for the build status
[23:39:09.850] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:09.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:69:0) after 1m0s
[23:40:09.919] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:69:0)
[23:40:09.919] Timer tick, asking Buildbucket for the build status
[23:40:10.033] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:10.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:70:0) after 1m0s
[23:41:10.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:70:0)
[23:41:10.109] Timer tick, asking Buildbucket for the build status
[23:41:10.274] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:10.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:71:0) after 1m0s
[23:42:10.331] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:71:0)
[23:42:10.331] Timer tick, asking Buildbucket for the build status
[23:42:10.814] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:10.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:72:0) after 1m0s
[23:43:10.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:72:0)
[23:43:10.863] Timer tick, asking Buildbucket for the build status
[23:43:10.998] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:10.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:73:0) after 1m0s
[23:44:11.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:73:0)
[23:44:11.054] Timer tick, asking Buildbucket for the build status
[23:44:11.149] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:11.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:74:0) after 1m0s
[23:45:11.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:74:0)
[23:45:11.221] Timer tick, asking Buildbucket for the build status
[23:45:11.336] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:11.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:75:0) after 1m0s
[23:46:11.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:75:0)
[23:46:11.442] Timer tick, asking Buildbucket for the build status
[23:46:11.538] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:11.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:76:0) after 1m0s
[23:47:11.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:76:0)
[23:47:11.618] Timer tick, asking Buildbucket for the build status
[23:47:11.676] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:11.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:77:0) after 1m0s
[23:48:11.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:77:0)
[23:48:11.772] Timer tick, asking Buildbucket for the build status
[23:48:12.013] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:12.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:78:0) after 1m0s
[23:49:12.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:78:0)
[23:49:12.043] Timer tick, asking Buildbucket for the build status
[23:49:12.169] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:12.169] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:79:0) after 1m0s
[23:50:12.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:79:0)
[23:50:12.193] Timer tick, asking Buildbucket for the build status
[23:50:12.291] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:12.291] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:80:0) after 1m0s
[23:51:12.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:80:0)
[23:51:12.342] Timer tick, asking Buildbucket for the build status
[23:51:12.414] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:12.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:81:0) after 1m0s
[23:52:12.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:81:0)
[23:52:12.472] Timer tick, asking Buildbucket for the build status
[23:52:12.543] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:12.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:82:0) after 1m0s
[23:53:12.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:82:0)
[23:53:12.543] Timer tick, asking Buildbucket for the build status
[23:53:12.681] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:12.681] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:83:0) after 1m0s
[23:54:12.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:83:0)
[23:54:12.728] Timer tick, asking Buildbucket for the build status
[23:54:13.101] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:13.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:84:0) after 1m0s
[23:55:13.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:84:0)
[23:55:13.126] Timer tick, asking Buildbucket for the build status
[23:55:13.275] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:13.275] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:85:0) after 1m0s
[23:56:13.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:85:0)
[23:56:13.298] Timer tick, asking Buildbucket for the build status
[23:56:13.558] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:13.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:86:0) after 1m0s
[23:57:13.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:86:0)
[23:57:13.615] Timer tick, asking Buildbucket for the build status
[23:57:14.064] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:14.064] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:87:0) after 1m0s
[23:58:14.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:87:0)
[23:58:14.085] Timer tick, asking Buildbucket for the build status
[23:58:14.724] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:14.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:88:0) after 1m0s
[23:59:14.698] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:88:0)
[23:59:14.698] Timer tick, asking Buildbucket for the build status
[23:59:14.818] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:14.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:89:0) after 1m0s
[00:00:14.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:89:0)
[00:00:14.851] Timer tick, asking Buildbucket for the build status
[00:00:14.946] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:14.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:90:0) after 1m0s
[00:01:16.798] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:90:0)
[00:01:16.798] Timer tick, asking Buildbucket for the build status
[00:01:16.891] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:16.891] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:91:0) after 1m0s
[00:02:16.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:91:0)
[00:02:16.907] Timer tick, asking Buildbucket for the build status
[00:02:17.245] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:17.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:92:0) after 1m0s
[00:03:17.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:92:0)
[00:03:17.270] Timer tick, asking Buildbucket for the build status
[00:03:17.473] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:17.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:93:0) after 1m0s
[00:04:17.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:93:0)
[00:04:17.495] Timer tick, asking Buildbucket for the build status
[00:04:17.587] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:17.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:94:0) after 1m0s
[00:05:17.638] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:94:0)
[00:05:17.638] Timer tick, asking Buildbucket for the build status
[00:05:17.732] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:17.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:95:0) after 1m0s
[00:06:17.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:95:0)
[00:06:17.758] Timer tick, asking Buildbucket for the build status
[00:06:18.018] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:18.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:96:0) after 1m0s
[00:07:18.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:96:0)
[00:07:18.069] Timer tick, asking Buildbucket for the build status
[00:07:18.166] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:18.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:97:0) after 1m0s
[00:08:18.178] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:97:0)
[00:08:18.178] Timer tick, asking Buildbucket for the build status
[00:08:18.608] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:18.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:98:0) after 1m0s
[00:09:18.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:98:0)
[00:09:18.696] Timer tick, asking Buildbucket for the build status
[00:09:19.109] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:19.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:99:0) after 1m0s
[00:10:19.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:99:0)
[00:10:19.157] Timer tick, asking Buildbucket for the build status
[00:10:19.318] Build 8861533246868436576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:19.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9026963309238706048:100:0) after 1m0s
[00:10:35.327] Received PubSub notification, asking Buildbucket for the build status
[00:10:35.435] Build 8861533246868436576: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:10:35.435] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607386232817035",
"created_by": "project:chromium",
"created_ts": "1607380360689692",
"failure_reason": "BUILD_FAILURE",
"id": "8861533246868436576",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dea9aceb679834381d3fcf72397acfc4d06e8226\"}}",
"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}, \"$kitchen/crbug_1150511_keys_with_int_value\": [\"$recipe_engine/buildbucket.build.infra.swarming.priority\", \"$recipe_engine/buildbucket.build.number\", \"buildnumber\"], \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"dea9aceb679834381d3fcf72397acfc4d06e8226\", \"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-6l2p\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21648, \"got_angle_revision\": \"a10d694e914ea0a2c3958f710b7607100a10899f\", \"got_dawn_revision\": \"042184128efea90552495d5054c3ae17b84cb3c3\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"dea9aceb679834381d3fcf72397acfc4d06e8226\", \"got_revision_cp\": \"refs/heads/master@{#834413}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"7bcd79eccf28007fe7a60ed50251d91ea4e65674\", \"got_v8_revision\": \"5a377bcb492ded6525dbabed85a77563e63c7cf7\", \"got_v8_revision_cp\": \"refs/heads/8.9.117@{#1}\", \"got_webrtc_revision\": \"bb1a28de3cf17476142e9de8ee12fe6c567d06c1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32789}\", \"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\": \"dea9aceb679834381d3fcf72397acfc4d06e8226\", \"swarm_hashes_refs/heads/master(at){#834413}_without_patch\": {\"absl_hardening_tests\": \"6116c9302e05ac35e15ef7d3dd4e38ed30ffe46a\", \"accessibility_unittests\": \"2684be5186b3b86b18f07de3305813384980b5de\", \"angle_unittests\": \"5143dda876b73c10939f73e570c2ab5fb61935ec\", \"app_list_unittests\": \"0cfd252ca66b47741426dccee85d5da9ee933549\", \"app_shell_unittests\": \"d0cc7d5709a1bf83a2f3a48fb80d5c32de5aa12e\", \"ash_unittests\": \"3234ff548e14b23efc8a2514776fe242e26f7511\", \"aura_unittests\": \"b81a750ef7ac930a8312fc36343f694724eb3a53\", \"base_unittests\": \"aae59892062f5cd6f847a92b01bd54153ad3b7ce\", \"base_util_unittests\": \"a824639cfe899abc060d7543d4df53c136dd823e\", \"blink_common_unittests\": \"8916be6045a9149c914561601af61051f33e581f\", \"blink_fuzzer_unittests\": \"c326d16d6a9fa723256cf6c29f45df45a2d8f81b\", \"blink_heap_unittests\": \"d30b1c4522bddc522434a082a1ccc3bad2f9d9c6\", \"blink_platform_unittests\": \"dbd2fc23a3be3cdea03b41e3d87d8d04e20177fd\", \"blink_unittests\": \"893f233be006ebf2c24e78aa26bca9a2a09569dd\", \"boringssl_crypto_tests\": \"4b213e0b140653cc36adcbbba65183f5299169a5\", \"boringssl_ssl_tests\": \"8fe8c1320ece886268f27c641b96ab1d5d082916\", \"browser_tests\": \"f3394d830f1ccb5e49c80b17a4ef4557fc24abd3\", \"capture_unittests\": \"394a2e3a42ce5d11b2ff4d5eef0fca393075f521\", \"cast_unittests\": \"ed2ad639d4b8d72e8df5a6b0c0c9dcd770afc0c3\", \"cc_unittests\": \"86fe098f6611202d124bc35201db1d58fe4774f4\", \"chrome_app_unittests\": \"ec589a412fa52e5b9b84434d71e2740099617d90\", \"chromedriver_unittests\": \"6ead423bd376356e4bd2a41062c22010ce0fb369\", \"chromeos_components_unittests\": \"504a2bcafa64228517c29600f9dcae8ad381c2f8\", \"chromeos_unittests\": \"a861f0b74e66d89b15254ce5b743e0705c3da88c\", \"components_browsertests\": \"96b666e891fabf56047fc42a07a801d6d4979978\", \"components_unittests\": \"03960a0c53a27510a678d2288a4c01c089fd2793\", \"compositor_unittests\": \"5f49146fe5d6eb8e9774f0777b4df31129916105\", \"content_browsertests\": \"b89c339580b7ed7c4b87dc78a9ce372cc3563ce6\", \"content_unittests\": \"db35400ff52d4c8eee3901f8c5ff86c47c4c2471\", \"crashpad_tests\": \"c337adc892cf7fff08c85c68e40b6a7918ab782d\", \"crypto_unittests\": \"c1b2b93cae0b8319dd64e230e10110e1f0079cd9\", \"dbus_unittests\": \"5dd67f165a2195e039248195a32137c23ae4621e\", \"device_unittests\": \"8dc737c7e26943d2761a73765bffcfd71bd284a5\", \"display_unittests\": \"a4e31ab659fb6bc389b203515f770a324d139563\", \"events_unittests\": \"3850ff41269355b75546d12e3e71ce3555b105a7\", \"exo_unittests\": \"fb78a3f51edfc5bb88d2a1e8107ea5f44a5a1ab6\", \"extensions_browsertests\": \"b91644b18f3a3eef9468b7ac23257136ffe21261\", \"extensions_unittests\": \"2177a4d8fef059906220f722e54425840fbaf1b8\", \"filesystem_service_unittests\": \"b99a776dcafb424929f4b86b382d0dae0d26c17f\", \"gcm_unit_tests\": \"5d6f0ac438f5b7d0497a969b0707686d18e12366\", \"gfx_unittests\": \"3dd750c81c4bbb93eb9f65e3dec588ebb5bd8b54\", \"gin_unittests\": \"4463c1ece03619186c9de732d756634d7ee8bf64\", \"gl_unittests_ozone\": \"b83ef2876e6aa27466cf2fd2b781b332912746fe\", \"google_apis_unittests\": \"b945ff1d5ac6cb0c28a0d0a544b8ff2870fa9e4e\", \"gpu_unittests\": \"1a3f5df0f49f722a1cfdbb9b9dfafe93f2748aec\", \"gwp_asan_unittests\": \"a2ba48b6843fa200638796e675727c42bf7ba27e\", \"interactive_ui_tests\": \"5e5ef7d36d509c911a74e37fa6a65ec50f4115dd\", \"ipc_tests\": \"44d8134f45e88df92f9c850322a57b705651b9df\", \"jingle_unittests\": \"858ef18363e750bea5209e9dbc489c713981782f\", \"keyboard_unittests\": \"fde762bf7476fed26fdf2eb7f0f74b158fb5ac34\", \"latency_unittests\": \"3328ea60c6218ac1bae65351edfe813edd68380c\", \"libjingle_xmpp_unittests\": \"ad6c3b57f63972733ab07f3bdfb9553569d59003\", \"liburlpattern_unittests\": \"8c08bd9429e3b34ebe0237b9629a812f33d4d3a5\", \"media_blink_unittests\": \"bdc2b0eb06f0ed679dbb4f5f0bbde2ae8400d6e8\", \"media_unittests\": \"c25fc64a6245551bae38ddb43b5223a4af09effd\", \"message_center_unittests\": \"4290ba4fe91d3c4c04b9a69fa3ada38eeb0f5103\", \"midi_unittests\": \"7c352028c419a777c09dd10f09c68b1c3d10d132\", \"mojo_core_unittests\": \"0ad0dab956ef280b616b203479c955bfc2ee5467\", \"mojo_unittests\": \"74742dabddf247e886c3b0d3e34533bfc23a135a\", \"nacl_helper_nonsfi_unittests\": \"0b9a7b67ffd0fd1fcab3c97f50d026e7e532e348\", \"nacl_loader_unittests\": \"ceda10e5d1d67d2a409e257b91088b658760ba2e\", \"native_theme_unittests\": \"7088ad3f48070ef21fe9e6519e2f4e25947b9599\", \"net_unittests\": \"7d5084589ffcd2a26e32b4522a97a307d3944452\", \"ozone_gl_unittests\": \"e11179faebddb96051fb527d8e7c253b4e14e4cf\", \"ozone_unittests\": \"ddd01afdc99c303fd61318c0b1ebcd5b4c4af9c8\", \"ozone_x11_unittests\": \"a4f2622dcae95e59c75ac0aa2efd364a384b8473\", \"pdf_unittests\": \"5864c5f2d1bd3a1e6b650dd796db4f00e509fc67\", \"perfetto_unittests\": \"65312c9e2b8742d00eecc97f449f843b8af3817d\", \"ppapi_unittests\": \"84c75b8530872cfb5f1b7a7a8777cde96dbfdf25\", \"printing_unittests\": \"55bfa781ac70325d9ff954c29006b6112acd14c0\", \"remoting_unittests\": \"abb69920dcb0cab535e6613a8945ca4b78627348\", \"sandbox_linux_unittests\": \"94e7000e22b725849ef4d2706f6e29f1adf866d8\", \"service_manager_unittests\": \"5cb1c75a8882b1e8594d8a26e54b17770ace07a5\", \"services_unittests\": \"580ff85b544c6bf5217d0f376d09d504f71676ce\", \"shell_dialogs_unittests\": \"4a82f641b22c035996736e4be545f506c78cb38a\", \"shell_encryption_unittests\": \"c15dd89c8ad4afc5942d9b41eacd8df615f1a3ab\", \"skia_unittests\": \"872bdc914c48c6e78b929b372b6d0b2f57efc7be\", \"snapshot_unittests\": \"443f4ece96de0782e81a1d1cce6497dfb0e6dead\", \"sql_unittests\": \"1bfb022218ca40429d7dc18d4d6b087170cf59a4\", \"storage_unittests\": \"be08d74f0f4d5d419e914f7a694ef257ee9ae55f\", \"sync_integration_tests\": \"6657ecb773fa060dfc27f0014c42d8cef32ec9e0\", \"traffic_annotation_auditor_unittests\": \"a7327b4fb8487aeef526daa84fc14049c9c4f201\", \"ui_base_unittests\": \"2675e4b955393d0248885a78b6760b2fd6d72a37\", \"ui_chromeos_unittests\": \"70b6563229cd161a9e14ed3031120e6d6f4775e3\", \"ui_touch_selection_unittests\": \"f1fa65396e9d8e9021a62426d1499bae0ae8dc7b\", \"unit_tests\": \"75ec6667a23acb5da0ed28e4538ec07f9f50edda\", \"url_unittests\": \"377f1951c4c964f126751cd058177f74eb50425f\", \"usage_time_limit_unittests\": \"6aa5dc908eabf9f669bba06f2deba38038c7bf81\", \"views_unittests\": \"727f8a20911d3c7adf93d70b3f39d34d8deb9c29\", \"viz_unittests\": \"bea7098d178ecdc6e78cae349233b8d426a442e0\", \"wm_unittests\": \"91b202899fb6dce43d1e7e445f5256e411752aeb\", \"wtf_unittests\": \"5d7868ece8a5c30c6795a981c20dd2e2775e55e7\", \"zlib_unittests\": \"d4207160ca036fe6b412475723c3b0bd3aadb026\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_b6367afba840c5eef309d6435187ce32d936dc893e5a665719688ecda1f7847e_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-6l2p\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5640-d0eb544\"], \"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": "1607380363254141",
"status": "COMPLETED",
"status_changed_ts": "1607380363551681",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21648",
"builder:linux-chromeos-dbg",
"buildset:commit/git/dea9aceb679834381d3fcf72397acfc4d06e8226",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dea9aceb679834381d3fcf72397acfc4d06e8226",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9026963309238706048",
"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/8861533246868436576/+/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:5058276c98efe710",
"user_agent:luci-scheduler"
],
"updated_ts": "1607386234664728",
"url": "https://ci.chromium.org/b/8861533246868436576",
"utcnow_ts": "1607386235413954"
}
}
[00:10:35.435] Invocation finished in 1h37m56.389980256s with status FAILED