[00:08:28.138] New invocation is queued and will start shortly
[00:08:29.174] Starting the invocation (attempt 1)
[00:08:29.340] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[00:08:29.340] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[00:08:29.340] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9081315460733850768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"23c23b32cff527e9a6d089598952c05a4a5c9032\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9081315460733850768",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/23c23b32cff527e9a6d089598952c05a4a5c9032",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23c23b32cff527e9a6d089598952c05a4a5c9032",
"gitiles_ref:refs/heads/master"
]
}
[00:08:30.422] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"created_by": "project:chromium",
"created_ts": "1555546109567658",
"id": "8915885398572503712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"23c23b32cff527e9a6d089598952c05a4a5c9032\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1555546110265535",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11924",
"builder:linux-chromeos-dbg",
"buildset:commit/git/23c23b32cff527e9a6d089598952c05a4a5c9032",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23c23b32cff527e9a6d089598952c05a4a5c9032",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9081315460733850768",
"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/8915885398572503712/+/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": "1555546110265654",
"url": "https://ci.chromium.org/b/8915885398572503712",
"utcnow_ts": "1555546110407849"
}
}
[00:08:30.422] Task URL: https://ci.chromium.org/b/8915885398572503712
[00:08:30.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:2:0) after 1m0s
[00:09:30.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:2:0)
[00:09:30.447] Timer tick, asking Buildbucket for the build status
[00:09:30.803] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:09:30.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:3:0) after 1m0s
[00:10:30.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:3:0)
[00:10:30.820] Timer tick, asking Buildbucket for the build status
[00:10:31.001] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:10:31.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:4:0) after 1m0s
[00:11:31.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:4:0)
[00:11:31.045] Timer tick, asking Buildbucket for the build status
[00:11:31.459] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:11:31.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:5:0) after 1m0s
[00:12:31.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:5:0)
[00:12:31.440] Timer tick, asking Buildbucket for the build status
[00:12:32.041] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:12:32.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:6:0) after 1m0s
[00:13:32.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:6:0)
[00:13:32.036] Timer tick, asking Buildbucket for the build status
[00:13:33.197] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:13:33.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:7:0) after 1m0s
[00:14:33.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:7:0)
[00:14:33.223] Timer tick, asking Buildbucket for the build status
[00:14:33.360] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:14:33.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:8:0) after 1m0s
[00:15:33.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:8:0)
[00:15:33.377] Timer tick, asking Buildbucket for the build status
[00:15:33.627] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:15:33.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:9:0) after 1m0s
[00:16:33.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:9:0)
[00:16:33.650] Timer tick, asking Buildbucket for the build status
[00:16:33.795] Build 8915885398572503712: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:16:33.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:10:0) after 1m0s
[00:16:55.868] Received PubSub notification, asking Buildbucket for the build status
[00:16:55.997] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:33.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:10:0)
[00:17:33.815] Timer tick, asking Buildbucket for the build status
[00:17:33.943] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:33.943] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:12:0) after 1m0s
[00:18:33.937] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:12:0)
[00:18:33.937] Timer tick, asking Buildbucket for the build status
[00:18:34.128] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:34.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:13:0) after 1m0s
[00:19:34.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:13:0)
[00:19:34.148] Timer tick, asking Buildbucket for the build status
[00:19:34.271] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:34.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:14:0) after 1m0s
[00:20:34.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:14:0)
[00:20:34.290] Timer tick, asking Buildbucket for the build status
[00:20:34.384] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:34.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:15:0) after 1m0s
[00:21:34.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:15:0)
[00:21:34.402] Timer tick, asking Buildbucket for the build status
[00:21:34.545] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:34.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:16:0) after 1m0s
[00:22:34.530] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:16:0)
[00:22:34.530] Timer tick, asking Buildbucket for the build status
[00:22:34.719] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:34.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:17:0) after 1m0s
[00:23:34.739] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:17:0)
[00:23:34.739] Timer tick, asking Buildbucket for the build status
[00:23:35.029] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:35.029] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:18:0) after 1m0s
[00:24:35.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:18:0)
[00:24:35.117] Timer tick, asking Buildbucket for the build status
[00:24:35.271] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:35.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:19:0) after 1m0s
[00:25:35.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:19:0)
[00:25:35.299] Timer tick, asking Buildbucket for the build status
[00:25:36.208] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:36.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:20:0) after 1m0s
[00:26:36.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:20:0)
[00:26:36.257] Timer tick, asking Buildbucket for the build status
[00:26:36.670] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:36.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:21:0) after 1m0s
[00:27:36.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:21:0)
[00:27:36.686] Timer tick, asking Buildbucket for the build status
[00:27:36.786] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:36.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:22:0) after 1m0s
[00:28:36.773] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:22:0)
[00:28:36.773] Timer tick, asking Buildbucket for the build status
[00:28:37.109] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:37.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:23:0) after 1m0s
[00:29:37.125] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:23:0)
[00:29:37.125] Timer tick, asking Buildbucket for the build status
[00:29:38.492] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:38.492] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:24:0) after 1m0s
[00:30:38.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:24:0)
[00:30:38.519] Timer tick, asking Buildbucket for the build status
[00:30:38.608] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:38.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:25:0) after 1m0s
[00:31:38.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:25:0)
[00:31:38.631] Timer tick, asking Buildbucket for the build status
[00:31:38.726] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:38.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:26:0) after 1m0s
[00:32:38.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:26:0)
[00:32:38.748] Timer tick, asking Buildbucket for the build status
[00:32:38.896] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:32:38.896] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:27:0) after 1m0s
[00:33:38.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:27:0)
[00:33:38.922] Timer tick, asking Buildbucket for the build status
[00:33:39.888] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:33:39.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:28:0) after 1m0s
[00:34:39.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:28:0)
[00:34:39.880] Timer tick, asking Buildbucket for the build status
[00:34:40.205] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:34:40.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:29:0) after 1m0s
[00:35:40.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:29:0)
[00:35:40.214] Timer tick, asking Buildbucket for the build status
[00:35:40.818] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:35:40.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:30:0) after 1m0s
[00:36:40.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:30:0)
[00:36:40.841] Timer tick, asking Buildbucket for the build status
[00:36:41.002] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:36:41.002] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:31:0) after 1m0s
[00:37:41.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:31:0)
[00:37:41.013] Timer tick, asking Buildbucket for the build status
[00:37:41.693] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:37:41.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:32:0) after 1m0s
[00:38:41.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:32:0)
[00:38:41.712] Timer tick, asking Buildbucket for the build status
[00:38:42.309] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:38:42.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:33:0) after 1m0s
[00:39:42.334] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:33:0)
[00:39:42.334] Timer tick, asking Buildbucket for the build status
[00:39:42.469] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:39:42.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:34:0) after 1m0s
[00:40:42.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:34:0)
[00:40:42.505] Timer tick, asking Buildbucket for the build status
[00:40:45.877] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:40:45.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:35:0) after 1m0s
[00:41:45.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:35:0)
[00:41:45.857] Timer tick, asking Buildbucket for the build status
[00:41:46.356] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:41:46.356] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:36:0) after 1m0s
[00:42:46.377] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:36:0)
[00:42:46.377] Timer tick, asking Buildbucket for the build status
[00:42:46.511] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:42:46.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:37:0) after 1m0s
[00:43:46.519] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:37:0)
[00:43:46.519] Timer tick, asking Buildbucket for the build status
[00:43:46.769] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:43:46.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:38:0) after 1m0s
[00:44:46.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:38:0)
[00:44:46.791] Timer tick, asking Buildbucket for the build status
[00:44:46.893] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:44:46.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:39:0) after 1m0s
[00:45:46.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:39:0)
[00:45:46.901] Timer tick, asking Buildbucket for the build status
[00:45:47.308] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:45:47.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:40:0) after 1m0s
[00:46:47.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:40:0)
[00:46:47.291] Timer tick, asking Buildbucket for the build status
[00:46:47.476] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:46:47.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:41:0) after 1m0s
[00:47:47.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:41:0)
[00:47:47.495] Timer tick, asking Buildbucket for the build status
[00:47:48.069] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:47:48.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:42:0) after 1m0s
[00:48:48.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:42:0)
[00:48:48.055] Timer tick, asking Buildbucket for the build status
[00:48:48.262] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:48:48.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:43:0) after 1m0s
[00:49:48.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:43:0)
[00:49:48.282] Timer tick, asking Buildbucket for the build status
[00:49:48.419] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:49:48.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:44:0) after 1m0s
[00:50:48.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:44:0)
[00:50:48.429] Timer tick, asking Buildbucket for the build status
[00:50:48.633] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:50:48.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:45:0) after 1m0s
[00:51:48.631] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:45:0)
[00:51:48.631] Timer tick, asking Buildbucket for the build status
[00:51:48.901] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:51:48.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:46:0) after 1m0s
[00:52:48.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:46:0)
[00:52:48.970] Timer tick, asking Buildbucket for the build status
[00:52:49.597] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:52:49.597] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:47:0) after 1m0s
[00:53:49.577] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:47:0)
[00:53:49.577] Timer tick, asking Buildbucket for the build status
[00:53:49.773] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:53:49.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:48:0) after 1m0s
[00:54:49.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:48:0)
[00:54:49.796] Timer tick, asking Buildbucket for the build status
[00:54:49.963] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:54:49.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:49:0) after 1m0s
[00:55:49.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:49:0)
[00:55:49.987] Timer tick, asking Buildbucket for the build status
[00:55:50.139] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:55:50.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:50:0) after 1m0s
[00:56:50.212] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:50:0)
[00:56:50.212] Timer tick, asking Buildbucket for the build status
[00:56:50.997] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:56:50.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:51:0) after 1m0s
[00:57:51.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:51:0)
[00:57:51.018] Timer tick, asking Buildbucket for the build status
[00:57:51.204] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:57:51.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:52:0) after 1m0s
[00:58:51.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:52:0)
[00:58:51.184] Timer tick, asking Buildbucket for the build status
[00:58:51.343] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:58:51.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:53:0) after 1m0s
[00:59:51.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:53:0)
[00:59:51.363] Timer tick, asking Buildbucket for the build status
[00:59:51.918] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:59:51.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:54:0) after 1m0s
[01:00:52.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:54:0)
[01:00:52.004] Timer tick, asking Buildbucket for the build status
[01:00:52.416] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:00:52.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:55:0) after 1m0s
[01:01:52.452] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:55:0)
[01:01:52.453] Timer tick, asking Buildbucket for the build status
[01:01:53.107] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:01:53.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:56:0) after 1m0s
[01:02:53.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:56:0)
[01:02:53.112] Timer tick, asking Buildbucket for the build status
[01:02:53.788] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:02:53.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:57:0) after 1m0s
[01:03:53.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:57:0)
[01:03:53.781] Timer tick, asking Buildbucket for the build status
[01:03:54.413] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:03:54.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:58:0) after 1m0s
[01:04:54.436] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:58:0)
[01:04:54.436] Timer tick, asking Buildbucket for the build status
[01:04:54.863] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:04:54.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:59:0) after 1m0s
[01:05:54.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:59:0)
[01:05:54.896] Timer tick, asking Buildbucket for the build status
[01:05:55.057] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:05:55.057] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:60:0) after 1m0s
[01:06:55.081] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:60:0)
[01:06:55.081] Timer tick, asking Buildbucket for the build status
[01:06:55.295] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:06:55.295] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:61:0) after 1m0s
[01:07:55.290] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:61:0)
[01:07:55.290] Timer tick, asking Buildbucket for the build status
[01:07:55.383] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:07:55.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:62:0) after 1m0s
[01:08:55.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:62:0)
[01:08:55.370] Timer tick, asking Buildbucket for the build status
[01:08:55.795] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:08:55.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:63:0) after 1m0s
[01:09:55.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:63:0)
[01:09:55.815] Timer tick, asking Buildbucket for the build status
[01:09:55.988] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:09:55.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:64:0) after 1m0s
[01:10:56.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:64:0)
[01:10:56.019] Timer tick, asking Buildbucket for the build status
[01:10:56.683] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:10:56.683] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:65:0) after 1m0s
[01:11:56.707] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:65:0)
[01:11:56.707] Timer tick, asking Buildbucket for the build status
[01:11:56.830] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:11:56.830] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:66:0) after 1m0s
[01:12:56.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:66:0)
[01:12:56.854] Timer tick, asking Buildbucket for the build status
[01:12:57.007] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:12:57.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:67:0) after 1m0s
[01:13:57.010] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:67:0)
[01:13:57.010] Timer tick, asking Buildbucket for the build status
[01:13:57.217] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:13:57.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:68:0) after 1m0s
[01:14:57.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:68:0)
[01:14:57.234] Timer tick, asking Buildbucket for the build status
[01:14:57.600] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:14:57.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:69:0) after 1m0s
[01:15:57.584] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:69:0)
[01:15:57.584] Timer tick, asking Buildbucket for the build status
[01:15:57.832] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:15:57.832] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:70:0) after 1m0s
[01:16:57.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:70:0)
[01:16:57.826] Timer tick, asking Buildbucket for the build status
[01:16:57.987] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:16:57.987] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:71:0) after 1m0s
[01:17:58.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:71:0)
[01:17:58.018] Timer tick, asking Buildbucket for the build status
[01:17:58.235] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:17:58.235] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:72:0) after 1m0s
[01:18:58.269] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:72:0)
[01:18:58.269] Timer tick, asking Buildbucket for the build status
[01:18:58.900] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:18:58.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:73:0) after 1m0s
[01:19:58.890] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:73:0)
[01:19:58.890] Timer tick, asking Buildbucket for the build status
[01:19:58.999] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:19:58.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:74:0) after 1m0s
[01:20:58.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:74:0)
[01:20:58.995] Timer tick, asking Buildbucket for the build status
[01:20:59.105] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:20:59.105] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:75:0) after 1m0s
[01:21:59.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:75:0)
[01:21:59.131] Timer tick, asking Buildbucket for the build status
[01:21:59.517] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:21:59.517] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:76:0) after 1m0s
[01:22:59.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:76:0)
[01:22:59.508] Timer tick, asking Buildbucket for the build status
[01:23:00.409] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:23:00.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:77:0) after 1m0s
[01:24:00.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:77:0)
[01:24:00.399] Timer tick, asking Buildbucket for the build status
[01:24:00.496] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:24:00.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:78:0) after 1m0s
[01:25:00.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:78:0)
[01:25:00.513] Timer tick, asking Buildbucket for the build status
[01:25:00.892] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:25:00.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:79:0) after 1m0s
[01:26:00.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:79:0)
[01:26:00.915] Timer tick, asking Buildbucket for the build status
[01:26:01.039] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:26:01.039] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:80:0) after 1m0s
[01:27:01.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:80:0)
[01:27:01.062] Timer tick, asking Buildbucket for the build status
[01:27:01.910] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:27:01.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:81:0) after 1m0s
[01:28:01.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:81:0)
[01:28:01.933] Timer tick, asking Buildbucket for the build status
[01:28:02.663] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:28:02.663] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:82:0) after 1m0s
[01:29:02.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:82:0)
[01:29:02.686] Timer tick, asking Buildbucket for the build status
[01:29:03.833] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:29:03.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:83:0) after 1m0s
[01:30:03.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:83:0)
[01:30:03.857] Timer tick, asking Buildbucket for the build status
[01:30:04.092] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:30:04.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:84:0) after 1m0s
[01:31:04.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:84:0)
[01:31:04.092] Timer tick, asking Buildbucket for the build status
[01:31:04.591] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:31:04.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:85:0) after 1m0s
[01:32:04.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:85:0)
[01:32:04.585] Timer tick, asking Buildbucket for the build status
[01:32:04.884] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:32:04.884] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:86:0) after 1m0s
[01:33:04.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:86:0)
[01:33:04.915] Timer tick, asking Buildbucket for the build status
[01:33:05.374] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:33:05.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:87:0) after 1m0s
[01:34:05.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:87:0)
[01:34:05.357] Timer tick, asking Buildbucket for the build status
[01:34:05.898] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:34:05.898] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:88:0) after 1m0s
[01:35:05.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:88:0)
[01:35:05.919] Timer tick, asking Buildbucket for the build status
[01:35:06.033] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:35:06.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:89:0) after 1m0s
[01:36:06.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:89:0)
[01:36:06.031] Timer tick, asking Buildbucket for the build status
[01:36:06.644] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:36:06.644] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:90:0) after 1m0s
[01:37:06.626] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:90:0)
[01:37:06.626] Timer tick, asking Buildbucket for the build status
[01:37:06.806] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:91:0) after 1m0s
[01:38:06.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:91:0)
[01:38:06.797] Timer tick, asking Buildbucket for the build status
[01:38:07.032] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:07.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:92:0) after 1m0s
[01:39:07.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:92:0)
[01:39:07.027] Timer tick, asking Buildbucket for the build status
[01:39:07.833] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:07.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:93:0) after 1m0s
[01:40:07.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:93:0)
[01:40:07.860] Timer tick, asking Buildbucket for the build status
[01:40:08.032] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:08.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:94:0) after 1m0s
[01:41:08.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:94:0)
[01:41:08.061] Timer tick, asking Buildbucket for the build status
[01:41:08.488] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:08.488] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:95:0) after 1m0s
[01:42:08.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:95:0)
[01:42:08.508] Timer tick, asking Buildbucket for the build status
[01:42:09.354] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:09.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:96:0) after 1m0s
[01:43:09.383] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:96:0)
[01:43:09.383] Timer tick, asking Buildbucket for the build status
[01:43:09.863] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:09.864] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:97:0) after 1m0s
[01:44:09.889] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:97:0)
[01:44:09.889] Timer tick, asking Buildbucket for the build status
[01:44:11.352] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:11.353] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:98:0) after 1m0s
[01:45:11.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:98:0)
[01:45:11.378] Timer tick, asking Buildbucket for the build status
[01:45:11.933] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:11.933] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:99:0) after 1m0s
[01:46:11.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:99:0)
[01:46:11.980] Timer tick, asking Buildbucket for the build status
[01:46:12.164] Build 8915885398572503712: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:12.164] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9081315460733850768:100:0) after 1m0s
[01:46:37.293] Received PubSub notification, asking Buildbucket for the build status
[01:46:37.541] Build 8915885398572503712: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[01:46:37.541] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "AUTO",
"completed_ts": "1555551996613566",
"created_by": "project:chromium",
"created_ts": "1555546109567658",
"id": "8915885398572503712",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"23c23b32cff527e9a6d089598952c05a4a5c9032\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/swarming/w/ir/cache\", \"temp_dir\": \"/b/swarming/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"swarm1567-c4\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 11924, \"got_angle_revision\": \"e3c7134c2717443e925adf37ed6de21eb0187cf2\", \"got_dawn_revision\": \"0c133bbe554e98c55b88f3dd3fab7b885aa5abcb\", \"got_nacl_revision\": \"6abc006f6760ec49350cd45e8bccbff4809725ac\", \"got_revision\": \"23c23b32cff527e9a6d089598952c05a4a5c9032\", \"got_revision_cp\": \"refs/heads/master@{#651972}\", \"got_swarming_client_revision\": \"aa60736aded9fc32a0e21a81f5fc51f6009d01f3\", \"got_v8_revision\": \"35b9bf5cf697b1c0fe4313c1313782d626d2afaa\", \"got_v8_revision_cp\": \"refs/heads/7.5.288@{#1}\", \"got_webrtc_revision\": \"797ede8e712f396ad55d3c15976dc69884feff67\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#27677}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.chromiumos\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"23c23b32cff527e9a6d089598952c05a4a5c9032\", \"swarm_hashes\": {\"accessibility_unittests\": \"bec7155a461712e4470cf02f6dba4c171fd05c39\", \"angle_unittests\": \"9418697ec20036d42cd533c288031a75ea4d8284\", \"app_list_unittests\": \"b092e39521c187d26c21708001d8f060eda9850b\", \"app_shell_unittests\": \"4adfce049d21bb0524a8b4e7cf457bfd41a72dfb\", \"ash_unittests\": \"5dfb1b30659544e46d620a3d8869d2ecdd1eb29e\", \"aura_unittests\": \"2ec53330b93d46ef23419482ee3df1a925f0a3ea\", \"base_unittests\": \"f7069e6d526abffa662cf80e6789bfbfcd9bf190\", \"blink_common_unittests\": \"6759896ee7da8452404fcd4bbc7bf43e54d350b8\", \"blink_fuzzer_unittests\": \"8c274116b685168fb045cc274a014f13fc15271a\", \"blink_heap_unittests\": \"13631657b64e254ae20935a9e255881882fd1c20\", \"blink_platform_unittests\": \"64aa52ba77d270a1d41b04e048d33dfb9e5c5aaa\", \"blink_unittests\": \"b9f952c5a3f9d8f9bc10af8696c0cdeb2ed330a6\", \"boringssl_crypto_tests\": \"a23c951a6bcce031619d0b90cc3a84c1cc238b50\", \"boringssl_ssl_tests\": \"998c628bd0dc2b6faa7f4bf298d6fa52d18f9edf\", \"browser_tests\": \"5308e550800a93c66522d4adc91693ec1f20b4b9\", \"cacheinvalidation_unittests\": \"f6c2e8806f7b8eb180fdfdf6dc58bea4e21af3fa\", \"capture_unittests\": \"1d782c71df11a89bf42d65cfb8b5e33e098334df\", \"cast_unittests\": \"95c338c5d5c573123ecfd3641d58488b167eb947\", \"cc_unittests\": \"68c322bb77b75b93e4cd13991af8b236fffd0535\", \"chrome_app_unittests\": \"ac925b6d55a959c119e71c79e6df974b72b579cb\", \"chromedriver_unittests\": \"0041966c60ea98f49d7f2c2dba8cdde1ac10f474\", \"chromeos_components_unittests\": \"f0f1e2b0c4496484559b6edd94c6be56fb5416d2\", \"chromeos_unittests\": \"91ba6ef5b225ca4f59bfa0f093e758e5ee775b80\", \"components_browsertests\": \"da0a011f1ba74ec3a5a3875c8fad0ea5b58de9e8\", \"components_unittests\": \"bab8767e35f7c2feb0c9e404ddb5b25d9af26a7b\", \"compositor_unittests\": \"242366dfc0b42c78310054ce79bbf5637fd257ac\", \"content_browsertests\": \"5bd5064154c10bb5c7f9cb018cd0c36395268123\", \"content_unittests\": \"a40c206b8b52babb686f80d52b593fef342375b5\", \"crypto_unittests\": \"c59bb3298fb96d983f4d6c591cdfd42b50f60a02\", \"dbus_unittests\": \"a4d53e68ad741541b80c7bc31db493d77912dabc\", \"device_unittests\": \"3747532b798e5b6a2d000dd684812cc7efbd71dd\", \"display_unittests\": \"d7e751d0fc01d213b0e1eec578a50146ae4a0856\", \"events_unittests\": \"16775133d284b21b9f08d179140731b141949d03\", \"exo_unittests\": \"b96e32ee3b9fb4f673237b275b90c2fb3231dee5\", \"extensions_browsertests\": \"f9044aba5a6a9c4ec2ab114bcb4430fe3748175b\", \"extensions_unittests\": \"d7c6933c61c61c32c218b77555c7cb3bfc1a8017\", \"filesystem_service_unittests\": \"aa913bcce9daa0c3c2b904b179c17ff5a0c8483f\", \"gcm_unit_tests\": \"fa84f3bfbe0b12e8bfb8b36796b00fa4e1e6fd06\", \"gfx_unittests\": \"3a29ff664032043504ea060a61acdc2865eb0fa7\", \"gin_unittests\": \"1001a8e4516b1ea7c8dc96d732a61e71e3c69ab7\", \"gl_unittests_ozone\": \"b440d99db837f4c09d9747149b5233dfa206032a\", \"google_apis_unittests\": \"76e148877fef35ca14b2ddad7d66b4dd08df38c0\", \"gpu_unittests\": \"443f325d95c03aef2069e00f6d8104c2270b32e4\", \"interactive_ui_tests\": \"43409ec9e47e7de0371aec78e5858e293c60e460\", \"ipc_tests\": \"d461598085186f876e182f697dcb4e407ecf3531\", \"jingle_unittests\": \"1c0821f20b56182ce6e1824488c409c1dae6c44c\", \"keyboard_unittests\": \"147791fa15f392d4d8f0e3ce5251e329e1cbcacf\", \"latency_unittests\": \"dff98b6e772f129cac451e9bf2efb7ae7825e3a5\", \"leveldb_service_unittests\": \"4a066583ee3ada174d6cf37f6850f66521d3f9a3\", \"libjingle_xmpp_unittests\": \"0b67eaca5f9c323a748974846a9942edf37e30be\", \"media_blink_unittests\": \"349872b32091cde760f6e6e22142ba0a5f9332d9\", \"media_service_unittests\": \"82da8ae61d0acc142514e621ce1238de8375ce28\", \"media_unittests\": \"ea073c34f16e3fcb8b61bde53ca81a61782a43c6\", \"message_center_unittests\": \"05708dd592a97dca3a0b237d308da8427f689e5d\", \"midi_unittests\": \"a86b9a6ce272c0720eddfe6ff14a620317d3f3b9\", \"mojo_core_unittests\": \"ea785a63f5350e585f8da8a120dcccfed2399cbe\", \"mojo_unittests\": \"ca9f3e21ee5d5554effc911bc66767850f8a11b3\", \"nacl_helper_nonsfi_unittests\": \"5ede33ae1ee314d7ea0fcb85da17a1b1e76410ac\", \"nacl_loader_unittests\": \"4d2346e3f558afeb6589371862b09e9d51dba8b3\", \"native_theme_unittests\": \"6b19c5f4df1297b99723ba9655d6d404f3b84757\", \"net_unittests\": \"83d6e72059ecde5476f59b75fd32e60e5b7ac2b0\", \"ozone_gl_unittests\": \"68c5a68d4dc1af5cc3c8c4b673f8cce9196c7759\", \"ozone_unittests\": \"3ca566cb10e4b145cff42b6f76813244af8c6838\", \"ozone_x11_unittests\": \"736f897cd44c8e33cc419e1d693463b9a41b0e14\", \"pdf_unittests\": \"a472e265c6e5bc34a4542c3feb88c5e68c0e2f8c\", \"perfetto_unittests\": \"ca598acb4d8ee05b74114c305fbf4d06c102c870\", \"ppapi_unittests\": \"9d540f014e20ef33e3cfb1a88cdca091f455f49f\", \"printing_unittests\": \"4c40c3e684e2138f9719ad2854bfca90cba07ddd\", \"remoting_unittests\": \"a366a697c1f464097c58e208666ef6de976d23c3\", \"sandbox_linux_unittests\": \"88d008d056a817a4d9456c98eb497cc400a694e2\", \"service_manager_unittests\": \"d5b287d75ba0c773662a5394abd30d9cf5a45be1\", \"services_unittests\": \"cbba552786dcdabcf3db090a1b310ed341cbf0bb\", \"shell_dialogs_unittests\": \"78c31ee0a41648cf565bfd078f321a289b2f6cf3\", \"skia_unittests\": \"0c3d49419a358429bd47da3e4bc31255a6aecf5c\", \"snapshot_unittests\": \"c770eb07020c03d03d3c74d8c52c5ecb8d779c13\", \"sql_unittests\": \"792cb178f4efa1cf065d9abe631563814758e909\", \"storage_unittests\": \"bbcd8e514d2cbceb3195fb7aa6e3961afb68d2d2\", \"sync_integration_tests\": \"7436a198b88dec868af73d2562bc43b64edc114e\", \"traffic_annotation_auditor_unittests\": \"b25e513fafc228e72938dc33d45c78ae06f3b31a\", \"ui_base_unittests\": \"018be56c7b4fdcee085e3fe132e44a4a7e1b7f25\", \"ui_chromeos_unittests\": \"8cb5fbc7070cee78dcf08554b720a033320fb983\", \"ui_touch_selection_unittests\": \"30c0bd0954ee911dcafe7b8649b53c7f11301f97\", \"unit_tests\": \"ee0de92808eb52a0c4cb8895dfc95794186d6bef\", \"url_unittests\": \"4c15e205ce070f84539c5ab419593faaee7eefac\", \"usage_time_limit_unittests\": \"1ee91adf22c7fc859fb62a011aefb3819f668eef\", \"views_unittests\": \"433cdf8cd250d78df8ceb685d4e5d4008fe4f948\", \"viz_unittests\": \"2606266d252aba4b857426939f46b8c503dab824\", \"wm_unittests\": \"448897121a2a006bdefc1da0975ed70cdc5ab100\", \"wtf_unittests\": \"96f5c26c6ea9d6f8752a090b8251f426350a3ad9\"}, \"swarm_hashes_refs/heads/master(at){#651972}_without_patch\": {\"accessibility_unittests\": \"bec7155a461712e4470cf02f6dba4c171fd05c39\", \"angle_unittests\": \"9418697ec20036d42cd533c288031a75ea4d8284\", \"app_list_unittests\": \"b092e39521c187d26c21708001d8f060eda9850b\", \"app_shell_unittests\": \"4adfce049d21bb0524a8b4e7cf457bfd41a72dfb\", \"ash_unittests\": \"5dfb1b30659544e46d620a3d8869d2ecdd1eb29e\", \"aura_unittests\": \"2ec53330b93d46ef23419482ee3df1a925f0a3ea\", \"base_unittests\": \"f7069e6d526abffa662cf80e6789bfbfcd9bf190\", \"blink_common_unittests\": \"6759896ee7da8452404fcd4bbc7bf43e54d350b8\", \"blink_fuzzer_unittests\": \"8c274116b685168fb045cc274a014f13fc15271a\", \"blink_heap_unittests\": \"13631657b64e254ae20935a9e255881882fd1c20\", \"blink_platform_unittests\": \"64aa52ba77d270a1d41b04e048d33dfb9e5c5aaa\", \"blink_unittests\": \"b9f952c5a3f9d8f9bc10af8696c0cdeb2ed330a6\", \"boringssl_crypto_tests\": \"a23c951a6bcce031619d0b90cc3a84c1cc238b50\", \"boringssl_ssl_tests\": \"998c628bd0dc2b6faa7f4bf298d6fa52d18f9edf\", \"browser_tests\": \"5308e550800a93c66522d4adc91693ec1f20b4b9\", \"cacheinvalidation_unittests\": \"f6c2e8806f7b8eb180fdfdf6dc58bea4e21af3fa\", \"capture_unittests\": \"1d782c71df11a89bf42d65cfb8b5e33e098334df\", \"cast_unittests\": \"95c338c5d5c573123ecfd3641d58488b167eb947\", \"cc_unittests\": \"68c322bb77b75b93e4cd13991af8b236fffd0535\", \"chrome_app_unittests\": \"ac925b6d55a959c119e71c79e6df974b72b579cb\", \"chromedriver_unittests\": \"0041966c60ea98f49d7f2c2dba8cdde1ac10f474\", \"chromeos_components_unittests\": \"f0f1e2b0c4496484559b6edd94c6be56fb5416d2\", \"chromeos_unittests\": \"91ba6ef5b225ca4f59bfa0f093e758e5ee775b80\", \"components_browsertests\": \"da0a011f1ba74ec3a5a3875c8fad0ea5b58de9e8\", \"components_unittests\": \"bab8767e35f7c2feb0c9e404ddb5b25d9af26a7b\", \"compositor_unittests\": \"242366dfc0b42c78310054ce79bbf5637fd257ac\", \"content_browsertests\": \"5bd5064154c10bb5c7f9cb018cd0c36395268123\", \"content_unittests\": \"a40c206b8b52babb686f80d52b593fef342375b5\", \"crypto_unittests\": \"c59bb3298fb96d983f4d6c591cdfd42b50f60a02\", \"dbus_unittests\": \"a4d53e68ad741541b80c7bc31db493d77912dabc\", \"device_unittests\": \"3747532b798e5b6a2d000dd684812cc7efbd71dd\", \"display_unittests\": \"d7e751d0fc01d213b0e1eec578a50146ae4a0856\", \"events_unittests\": \"16775133d284b21b9f08d179140731b141949d03\", \"exo_unittests\": \"b96e32ee3b9fb4f673237b275b90c2fb3231dee5\", \"extensions_browsertests\": \"f9044aba5a6a9c4ec2ab114bcb4430fe3748175b\", \"extensions_unittests\": \"d7c6933c61c61c32c218b77555c7cb3bfc1a8017\", \"filesystem_service_unittests\": \"aa913bcce9daa0c3c2b904b179c17ff5a0c8483f\", \"gcm_unit_tests\": \"fa84f3bfbe0b12e8bfb8b36796b00fa4e1e6fd06\", \"gfx_unittests\": \"3a29ff664032043504ea060a61acdc2865eb0fa7\", \"gin_unittests\": \"1001a8e4516b1ea7c8dc96d732a61e71e3c69ab7\", \"gl_unittests_ozone\": \"b440d99db837f4c09d9747149b5233dfa206032a\", \"google_apis_unittests\": \"76e148877fef35ca14b2ddad7d66b4dd08df38c0\", \"gpu_unittests\": \"443f325d95c03aef2069e00f6d8104c2270b32e4\", \"interactive_ui_tests\": \"43409ec9e47e7de0371aec78e5858e293c60e460\", \"ipc_tests\": \"d461598085186f876e182f697dcb4e407ecf3531\", \"jingle_unittests\": \"1c0821f20b56182ce6e1824488c409c1dae6c44c\", \"keyboard_unittests\": \"147791fa15f392d4d8f0e3ce5251e329e1cbcacf\", \"latency_unittests\": \"dff98b6e772f129cac451e9bf2efb7ae7825e3a5\", \"leveldb_service_unittests\": \"4a066583ee3ada174d6cf37f6850f66521d3f9a3\", \"libjingle_xmpp_unittests\": \"0b67eaca5f9c323a748974846a9942edf37e30be\", \"media_blink_unittests\": \"349872b32091cde760f6e6e22142ba0a5f9332d9\", \"media_service_unittests\": \"82da8ae61d0acc142514e621ce1238de8375ce28\", \"media_unittests\": \"ea073c34f16e3fcb8b61bde53ca81a61782a43c6\", \"message_center_unittests\": \"05708dd592a97dca3a0b237d308da8427f689e5d\", \"midi_unittests\": \"a86b9a6ce272c0720eddfe6ff14a620317d3f3b9\", \"mojo_core_unittests\": \"ea785a63f5350e585f8da8a120dcccfed2399cbe\", \"mojo_unittests\": \"ca9f3e21ee5d5554effc911bc66767850f8a11b3\", \"nacl_helper_nonsfi_unittests\": \"5ede33ae1ee314d7ea0fcb85da17a1b1e76410ac\", \"nacl_loader_unittests\": \"4d2346e3f558afeb6589371862b09e9d51dba8b3\", \"native_theme_unittests\": \"6b19c5f4df1297b99723ba9655d6d404f3b84757\", \"net_unittests\": \"83d6e72059ecde5476f59b75fd32e60e5b7ac2b0\", \"ozone_gl_unittests\": \"68c5a68d4dc1af5cc3c8c4b673f8cce9196c7759\", \"ozone_unittests\": \"3ca566cb10e4b145cff42b6f76813244af8c6838\", \"ozone_x11_unittests\": \"736f897cd44c8e33cc419e1d693463b9a41b0e14\", \"pdf_unittests\": \"a472e265c6e5bc34a4542c3feb88c5e68c0e2f8c\", \"perfetto_unittests\": \"ca598acb4d8ee05b74114c305fbf4d06c102c870\", \"ppapi_unittests\": \"9d540f014e20ef33e3cfb1a88cdca091f455f49f\", \"printing_unittests\": \"4c40c3e684e2138f9719ad2854bfca90cba07ddd\", \"remoting_unittests\": \"a366a697c1f464097c58e208666ef6de976d23c3\", \"sandbox_linux_unittests\": \"88d008d056a817a4d9456c98eb497cc400a694e2\", \"service_manager_unittests\": \"d5b287d75ba0c773662a5394abd30d9cf5a45be1\", \"services_unittests\": \"cbba552786dcdabcf3db090a1b310ed341cbf0bb\", \"shell_dialogs_unittests\": \"78c31ee0a41648cf565bfd078f321a289b2f6cf3\", \"skia_unittests\": \"0c3d49419a358429bd47da3e4bc31255a6aecf5c\", \"snapshot_unittests\": \"c770eb07020c03d03d3c74d8c52c5ecb8d779c13\", \"sql_unittests\": \"792cb178f4efa1cf065d9abe631563814758e909\", \"storage_unittests\": \"bbcd8e514d2cbceb3195fb7aa6e3961afb68d2d2\", \"sync_integration_tests\": \"7436a198b88dec868af73d2562bc43b64edc114e\", \"traffic_annotation_auditor_unittests\": \"b25e513fafc228e72938dc33d45c78ae06f3b31a\", \"ui_base_unittests\": \"018be56c7b4fdcee085e3fe132e44a4a7e1b7f25\", \"ui_chromeos_unittests\": \"8cb5fbc7070cee78dcf08554b720a033320fb983\", \"ui_touch_selection_unittests\": \"30c0bd0954ee911dcafe7b8649b53c7f11301f97\", \"unit_tests\": \"ee0de92808eb52a0c4cb8895dfc95794186d6bef\", \"url_unittests\": \"4c15e205ce070f84539c5ab419593faaee7eefac\", \"usage_time_limit_unittests\": \"1ee91adf22c7fc859fb62a011aefb3819f668eef\", \"views_unittests\": \"433cdf8cd250d78df8ceb685d4e5d4008fe4f948\", \"viz_unittests\": \"2606266d252aba4b857426939f46b8c503dab824\", \"wm_unittests\": \"448897121a2a006bdefc1da0975ed70cdc5ab100\", \"wtf_unittests\": \"96f5c26c6ea9d6f8752a090b8251f426350a3ad9\"}}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"linux-chromeos-dbg\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"swarm1567-c4\"], \"image\": [\"chrome-trusty-18042300-b7223b463e3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4260-fb32526\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1555546614082057",
"status": "COMPLETED",
"status_changed_ts": "1555551996946867",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/11924",
"builder:linux-chromeos-dbg",
"buildset:commit/git/23c23b32cff527e9a6d089598952c05a4a5c9032",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/23c23b32cff527e9a6d089598952c05a4a5c9032",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9081315460733850768",
"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/8915885398572503712/+/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:44469783429aa910",
"user_agent:luci-scheduler"
],
"updated_ts": "1555551996949355",
"url": "https://ci.chromium.org/b/8915885398572503712",
"utcnow_ts": "1555551997523763"
}
}
[01:46:37.541] Invocation finished in 1h38m9.418221879s with status SUCCEEDED