[16:32:12.208] New invocation is queued and will start shortly
[16:32:13.348] Starting the invocation (attempt 1)
[16:32:13.412] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:32:13.412] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:32:13.412] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028797925975704608",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"269f716102142b6e73fa85b4a818432cac79855c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9028797925975704608",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/269f716102142b6e73fa85b4a818432cac79855c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/269f716102142b6e73fa85b4a818432cac79855c",
"gitiles_ref:refs/heads/master"
]
}
[16:32:14.288] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605630733558351",
"id": "8863367863887001952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"269f716102142b6e73fa85b4a818432cac79855c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605630734091884",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21356",
"builder:linux-chromeos-dbg",
"buildset:commit/git/269f716102142b6e73fa85b4a818432cac79855c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/269f716102142b6e73fa85b4a818432cac79855c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028797925975704608",
"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/8863367863887001952/+/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": "1605630734092002",
"url": "https://ci.chromium.org/b/8863367863887001952",
"utcnow_ts": "1605630734270345"
}
}
[16:32:14.288] Task URL: https://ci.chromium.org/b/8863367863887001952
[16:32:14.288] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:2:0) after 1m0s
[16:32:17.185] Received PubSub notification, asking Buildbucket for the build status
[16:32:17.283] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:14.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:2:0)
[16:33:14.347] Timer tick, asking Buildbucket for the build status
[16:33:14.459] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:14.459] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:4:0) after 1m0s
[16:34:14.532] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:4:0)
[16:34:14.532] Timer tick, asking Buildbucket for the build status
[16:34:14.777] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:14.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:5:0) after 1m0s
[16:35:14.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:5:0)
[16:35:14.812] Timer tick, asking Buildbucket for the build status
[16:35:14.938] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:14.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:6:0) after 1m0s
[16:36:14.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:6:0)
[16:36:14.983] Timer tick, asking Buildbucket for the build status
[16:36:15.097] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:15.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:7:0) after 1m0s
[16:37:15.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:7:0)
[16:37:15.122] Timer tick, asking Buildbucket for the build status
[16:37:15.251] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:15.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:8:0) after 1m0s
[16:38:15.319] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:8:0)
[16:38:15.319] Timer tick, asking Buildbucket for the build status
[16:38:15.474] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:15.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:9:0) after 1m0s
[16:39:15.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:9:0)
[16:39:15.505] Timer tick, asking Buildbucket for the build status
[16:39:15.818] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:15.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:10:0) after 1m0s
[16:40:15.882] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:10:0)
[16:40:15.882] Timer tick, asking Buildbucket for the build status
[16:40:16.317] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:16.317] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:11:0) after 1m0s
[16:41:16.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:11:0)
[16:41:16.448] Timer tick, asking Buildbucket for the build status
[16:41:16.627] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:12:0) after 1m0s
[16:42:16.700] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:12:0)
[16:42:16.700] Timer tick, asking Buildbucket for the build status
[16:42:16.759] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:16.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:13:0) after 1m0s
[16:43:16.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:13:0)
[16:43:16.792] Timer tick, asking Buildbucket for the build status
[16:43:17.117] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:17.117] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:14:0) after 1m0s
[16:44:17.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:14:0)
[16:44:17.213] Timer tick, asking Buildbucket for the build status
[16:44:17.283] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:17.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:15:0) after 1m0s
[16:45:17.304] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:15:0)
[16:45:17.304] Timer tick, asking Buildbucket for the build status
[16:45:17.538] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:17.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:16:0) after 1m0s
[16:46:17.585] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:16:0)
[16:46:17.585] Timer tick, asking Buildbucket for the build status
[16:46:18.015] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:18.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:17:0) after 1m0s
[16:47:18.055] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:17:0)
[16:47:18.055] Timer tick, asking Buildbucket for the build status
[16:47:18.627] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:18.627] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:18:0) after 1m0s
[16:48:18.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:18:0)
[16:48:18.780] Timer tick, asking Buildbucket for the build status
[16:48:18.844] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:18.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:19:0) after 1m0s
[16:49:18.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:19:0)
[16:49:18.892] Timer tick, asking Buildbucket for the build status
[16:49:19.189] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:19.189] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:20:0) after 1m0s
[16:50:19.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:20:0)
[16:50:19.329] Timer tick, asking Buildbucket for the build status
[16:50:19.403] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:19.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:21:0) after 1m0s
[16:51:19.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:21:0)
[16:51:19.470] Timer tick, asking Buildbucket for the build status
[16:51:19.540] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:19.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:22:0) after 1m0s
[16:52:19.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:22:0)
[16:52:19.568] Timer tick, asking Buildbucket for the build status
[16:52:20.408] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:20.408] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:23:0) after 1m0s
[16:53:20.443] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:23:0)
[16:53:20.443] Timer tick, asking Buildbucket for the build status
[16:53:20.868] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:20.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:24:0) after 1m0s
[16:54:20.918] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:24:0)
[16:54:20.918] Timer tick, asking Buildbucket for the build status
[16:54:20.982] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:20.982] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:25:0) after 1m0s
[16:55:21.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:25:0)
[16:55:21.067] Timer tick, asking Buildbucket for the build status
[16:55:21.148] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:21.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:26:0) after 1m0s
[16:56:21.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:26:0)
[16:56:21.203] Timer tick, asking Buildbucket for the build status
[16:56:21.271] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:21.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:27:0) after 1m0s
[16:57:21.321] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:27:0)
[16:57:21.321] Timer tick, asking Buildbucket for the build status
[16:57:21.433] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:21.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:28:0) after 1m0s
[16:58:21.489] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:28:0)
[16:58:21.489] Timer tick, asking Buildbucket for the build status
[16:58:21.582] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:21.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:29:0) after 1m0s
[16:59:21.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:29:0)
[16:59:21.641] Timer tick, asking Buildbucket for the build status
[16:59:22.848] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:22.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:30:0) after 1m0s
[17:00:22.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:30:0)
[17:00:22.939] Timer tick, asking Buildbucket for the build status
[17:00:23.033] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:23.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:31:0) after 1m0s
[17:01:23.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:31:0)
[17:01:23.088] Timer tick, asking Buildbucket for the build status
[17:01:23.202] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:23.202] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:32:0) after 1m0s
[17:02:23.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:32:0)
[17:02:23.222] Timer tick, asking Buildbucket for the build status
[17:02:23.371] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:23.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:33:0) after 1m0s
[17:03:23.362] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:33:0)
[17:03:23.362] Timer tick, asking Buildbucket for the build status
[17:03:23.426] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:23.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:34:0) after 1m0s
[17:04:23.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:34:0)
[17:04:23.490] Timer tick, asking Buildbucket for the build status
[17:04:23.605] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:23.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:35:0) after 1m0s
[17:05:23.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:35:0)
[17:05:23.659] Timer tick, asking Buildbucket for the build status
[17:05:23.737] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:23.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:36:0) after 1m0s
[17:06:23.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:36:0)
[17:06:23.820] Timer tick, asking Buildbucket for the build status
[17:06:23.927] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:23.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:37:0) after 1m0s
[17:07:23.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:37:0)
[17:07:23.952] Timer tick, asking Buildbucket for the build status
[17:07:24.098] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:24.098] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:38:0) after 1m0s
[17:08:24.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:38:0)
[17:08:24.145] Timer tick, asking Buildbucket for the build status
[17:08:24.225] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:24.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:39:0) after 1m0s
[17:09:24.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:39:0)
[17:09:24.296] Timer tick, asking Buildbucket for the build status
[17:09:24.419] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:24.419] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:40:0) after 1m0s
[17:10:24.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:40:0)
[17:10:24.464] Timer tick, asking Buildbucket for the build status
[17:10:24.568] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:24.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:41:0) after 1m0s
[17:11:24.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:41:0)
[17:11:24.613] Timer tick, asking Buildbucket for the build status
[17:11:24.675] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:24.675] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:42:0) after 1m0s
[17:12:24.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:42:0)
[17:12:24.670] Timer tick, asking Buildbucket for the build status
[17:12:24.807] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:24.807] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:43:0) after 1m0s
[17:13:24.862] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:43:0)
[17:13:24.862] Timer tick, asking Buildbucket for the build status
[17:13:24.977] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:24.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:44:0) after 1m0s
[17:14:25.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:44:0)
[17:14:25.126] Timer tick, asking Buildbucket for the build status
[17:14:26.889] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:26.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:45:0) after 1m0s
[17:15:27.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:45:0)
[17:15:27.014] Timer tick, asking Buildbucket for the build status
[17:15:27.094] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:27.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:46:0) after 1m0s
[17:16:27.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:46:0)
[17:16:27.127] Timer tick, asking Buildbucket for the build status
[17:16:27.285] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:27.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:47:0) after 1m0s
[17:17:27.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:47:0)
[17:17:27.337] Timer tick, asking Buildbucket for the build status
[17:17:28.333] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:28.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:48:0) after 1m0s
[17:18:28.415] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:48:0)
[17:18:28.415] Timer tick, asking Buildbucket for the build status
[17:18:28.553] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:28.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:49:0) after 1m0s
[17:19:28.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:49:0)
[17:19:28.637] Timer tick, asking Buildbucket for the build status
[17:19:28.770] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:28.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:50:0) after 1m0s
[17:20:28.857] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:50:0)
[17:20:28.857] Timer tick, asking Buildbucket for the build status
[17:20:29.536] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:29.536] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:51:0) after 1m0s
[17:21:29.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:51:0)
[17:21:29.703] Timer tick, asking Buildbucket for the build status
[17:21:30.473] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:30.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:52:0) after 1m0s
[17:22:30.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:52:0)
[17:22:30.604] Timer tick, asking Buildbucket for the build status
[17:22:30.742] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:30.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:53:0) after 1m0s
[17:23:30.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:53:0)
[17:23:30.793] Timer tick, asking Buildbucket for the build status
[17:23:31.059] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:31.059] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:54:0) after 1m0s
[17:24:31.087] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:54:0)
[17:24:31.087] Timer tick, asking Buildbucket for the build status
[17:24:31.218] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:31.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:55:0) after 1m0s
[17:25:31.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:55:0)
[17:25:31.298] Timer tick, asking Buildbucket for the build status
[17:25:31.360] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:31.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:56:0) after 1m0s
[17:26:31.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:56:0)
[17:26:31.397] Timer tick, asking Buildbucket for the build status
[17:26:31.541] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:31.541] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:57:0) after 1m0s
[17:27:31.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:57:0)
[17:27:31.597] Timer tick, asking Buildbucket for the build status
[17:27:32.336] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:32.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:58:0) after 1m0s
[17:28:32.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:58:0)
[17:28:32.796] Timer tick, asking Buildbucket for the build status
[17:28:33.095] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:33.095] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:59:0) after 1m0s
[17:29:33.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:59:0)
[17:29:33.238] Timer tick, asking Buildbucket for the build status
[17:29:33.525] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:33.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:60:0) after 1m0s
[17:30:33.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:60:0)
[17:30:33.611] Timer tick, asking Buildbucket for the build status
[17:30:33.781] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:33.781] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:61:0) after 1m0s
[17:31:33.853] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:61:0)
[17:31:33.853] Timer tick, asking Buildbucket for the build status
[17:31:34.126] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:34.126] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:62:0) after 1m0s
[17:32:34.142] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:62:0)
[17:32:34.142] Timer tick, asking Buildbucket for the build status
[17:32:34.351] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:34.351] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:63:0) after 1m0s
[17:33:34.416] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:63:0)
[17:33:34.416] Timer tick, asking Buildbucket for the build status
[17:33:34.728] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:34.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:64:0) after 1m0s
[17:34:34.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:64:0)
[17:34:34.894] Timer tick, asking Buildbucket for the build status
[17:34:34.997] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:34.997] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:65:0) after 1m0s
[17:35:35.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:65:0)
[17:35:35.093] Timer tick, asking Buildbucket for the build status
[17:35:35.625] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:35.625] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:66:0) after 1m0s
[17:36:35.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:66:0)
[17:36:35.694] Timer tick, asking Buildbucket for the build status
[17:36:36.099] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:36.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:67:0) after 1m0s
[17:37:36.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:67:0)
[17:37:36.176] Timer tick, asking Buildbucket for the build status
[17:37:36.297] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:36.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:68:0) after 1m0s
[17:38:36.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:68:0)
[17:38:36.298] Timer tick, asking Buildbucket for the build status
[17:38:36.447] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:36.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:69:0) after 1m0s
[17:39:36.482] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:69:0)
[17:39:36.482] Timer tick, asking Buildbucket for the build status
[17:39:37.728] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:37.728] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:70:0) after 1m0s
[17:40:37.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:70:0)
[17:40:37.820] Timer tick, asking Buildbucket for the build status
[17:40:37.914] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:37.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:71:0) after 1m0s
[17:41:37.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:71:0)
[17:41:37.981] Timer tick, asking Buildbucket for the build status
[17:41:38.147] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:38.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:72:0) after 1m0s
[17:42:38.198] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:72:0)
[17:42:38.198] Timer tick, asking Buildbucket for the build status
[17:42:38.567] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:38.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:73:0) after 1m0s
[17:43:38.596] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:73:0)
[17:43:38.596] Timer tick, asking Buildbucket for the build status
[17:43:38.727] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:38.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:74:0) after 1m0s
[17:44:38.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:74:0)
[17:44:38.758] Timer tick, asking Buildbucket for the build status
[17:44:39.139] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:39.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:75:0) after 1m0s
[17:45:39.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:75:0)
[17:45:39.202] Timer tick, asking Buildbucket for the build status
[17:45:41.733] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:41.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:76:0) after 1m0s
[17:46:41.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:76:0)
[17:46:41.880] Timer tick, asking Buildbucket for the build status
[17:46:42.311] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:42.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:77:0) after 1m0s
[17:47:42.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:77:0)
[17:47:42.340] Timer tick, asking Buildbucket for the build status
[17:47:42.495] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:42.495] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:78:0) after 1m0s
[17:48:42.574] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:78:0)
[17:48:42.574] Timer tick, asking Buildbucket for the build status
[17:48:43.510] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:43.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:79:0) after 1m0s
[17:49:43.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:79:0)
[17:49:43.553] Timer tick, asking Buildbucket for the build status
[17:49:43.726] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:43.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:80:0) after 1m0s
[17:50:43.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:80:0)
[17:50:43.843] Timer tick, asking Buildbucket for the build status
[17:50:44.096] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:44.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:81:0) after 1m0s
[17:51:44.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:81:0)
[17:51:44.124] Timer tick, asking Buildbucket for the build status
[17:51:44.289] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:44.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:82:0) after 1m0s
[17:52:44.292] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:82:0)
[17:52:44.292] Timer tick, asking Buildbucket for the build status
[17:52:44.642] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:44.642] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:83:0) after 1m0s
[17:53:44.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:83:0)
[17:53:44.629] Timer tick, asking Buildbucket for the build status
[17:53:44.715] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:44.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:84:0) after 1m0s
[17:54:44.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:84:0)
[17:54:44.750] Timer tick, asking Buildbucket for the build status
[17:54:44.845] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:44.845] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:85:0) after 1m0s
[17:55:44.884] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:85:0)
[17:55:44.884] Timer tick, asking Buildbucket for the build status
[17:55:44.999] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:44.999] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:86:0) after 1m0s
[17:56:45.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:86:0)
[17:56:45.140] Timer tick, asking Buildbucket for the build status
[17:56:45.217] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:45.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:87:0) after 1m0s
[17:57:45.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:87:0)
[17:57:45.282] Timer tick, asking Buildbucket for the build status
[17:57:45.381] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:45.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:88:0) after 1m0s
[17:58:45.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:88:0)
[17:58:45.449] Timer tick, asking Buildbucket for the build status
[17:58:45.565] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:45.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:89:0) after 1m0s
[17:59:45.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:89:0)
[17:59:45.641] Timer tick, asking Buildbucket for the build status
[17:59:45.703] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:45.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:90:0) after 1m0s
[18:00:45.752] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:90:0)
[18:00:45.752] Timer tick, asking Buildbucket for the build status
[18:00:45.868] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:45.868] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:91:0) after 1m0s
[18:01:45.893] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:91:0)
[18:01:45.893] Timer tick, asking Buildbucket for the build status
[18:01:46.284] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:46.284] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:92:0) after 1m0s
[18:02:46.350] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:92:0)
[18:02:46.350] Timer tick, asking Buildbucket for the build status
[18:02:46.682] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:46.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:93:0) after 1m0s
[18:03:46.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:93:0)
[18:03:46.710] Timer tick, asking Buildbucket for the build status
[18:03:47.022] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:47.022] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:94:0) after 1m0s
[18:04:47.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:94:0)
[18:04:47.066] Timer tick, asking Buildbucket for the build status
[18:04:47.399] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:47.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:95:0) after 1m0s
[18:05:47.470] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:95:0)
[18:05:47.470] Timer tick, asking Buildbucket for the build status
[18:05:47.565] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:47.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:96:0) after 1m0s
[18:06:47.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:96:0)
[18:06:47.663] Timer tick, asking Buildbucket for the build status
[18:06:47.925] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:47.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:97:0) after 1m0s
[18:07:47.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:97:0)
[18:07:47.922] Timer tick, asking Buildbucket for the build status
[18:07:48.902] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:48.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:98:0) after 1m0s
[18:08:49.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:98:0)
[18:08:49.032] Timer tick, asking Buildbucket for the build status
[18:08:49.174] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:49.174] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:99:0) after 1m0s
[18:09:49.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:99:0)
[18:09:49.229] Timer tick, asking Buildbucket for the build status
[18:09:49.392] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:49.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:100:0) after 1m0s
[18:10:49.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:100:0)
[18:10:49.397] Timer tick, asking Buildbucket for the build status
[18:10:49.600] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:49.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:101:0) after 1m0s
[18:11:49.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:101:0)
[18:11:49.681] Timer tick, asking Buildbucket for the build status
[18:11:49.795] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:102:0) after 1m0s
[18:12:49.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:102:0)
[18:12:49.871] Timer tick, asking Buildbucket for the build status
[18:12:50.413] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:50.413] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:103:0) after 1m0s
[18:13:50.460] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:103:0)
[18:13:50.460] Timer tick, asking Buildbucket for the build status
[18:13:50.540] Build 8863367863887001952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:50.540] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9028797925975704608:104:0) after 1m0s
[18:14:26.884] Received PubSub notification, asking Buildbucket for the build status
[18:14:27.219] Build 8863367863887001952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:14:27.219] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605636865878460",
"created_by": "project:chromium",
"created_ts": "1605630733558351",
"id": "8863367863887001952",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"269f716102142b6e73fa85b4a818432cac79855c\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"269f716102142b6e73fa85b4a818432cac79855c\", \"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-19-g34z\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21356, \"got_angle_revision\": \"2f5d646c928eb989467cf53ed17e2e8d7e7ad357\", \"got_dawn_revision\": \"d98e8b70bbb198ebd665a570880ccc7b20e56198\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"269f716102142b6e73fa85b4a818432cac79855c\", \"got_revision_cp\": \"refs/heads/master@{#828221}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"04515da400d5fbc22d852af1369c4d46bd54991e\", \"got_v8_revision\": \"15247228bbf879eab29da6c7a0b1a608fccbc1fa\", \"got_v8_revision_cp\": \"refs/heads/8.9.4@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"269f716102142b6e73fa85b4a818432cac79855c\", \"swarm_hashes_refs/heads/master(at){#828221}_without_patch\": {\"absl_hardening_tests\": \"5866b3d8350d07c21fca22b205267464438e155f\", \"accessibility_unittests\": \"1ab574b39497523afd2530770a9e84426d7ca593\", \"angle_unittests\": \"22fb1c1e04e43a00e3ea4d32c2c3f02df351175c\", \"app_list_unittests\": \"66299472c9790db633bf67757d7385588a1309b2\", \"app_shell_unittests\": \"08b575fc170c8b9e1607432eae18c2097a8a8094\", \"ash_unittests\": \"a27b8e55f6fc743329f39b10c2175d92832fd1b9\", \"aura_unittests\": \"0c3e50df616b869cbcc96a864993267aa495f8d5\", \"base_unittests\": \"b7b42aef49182b4f65a79316a169e413a91328d0\", \"base_util_unittests\": \"26c567b303899ee24b2f22c788514f414245c768\", \"blink_common_unittests\": \"70fdec655e76e0503601fe1d2efd7ad0c5ce4130\", \"blink_fuzzer_unittests\": \"4a2dae94b8cee3ccce1cd76ccf94df7567815a12\", \"blink_heap_unittests\": \"9fdd270784537577b97acb2a6d00691a3d52b232\", \"blink_platform_unittests\": \"9b1a519b75727fd2d857dba337b0859a29b815f5\", \"blink_unittests\": \"eb0aef8a27dab7889d79f54f6059f5f552e975e8\", \"boringssl_crypto_tests\": \"aa29836a3516fc074b5210090678ae99f4dda798\", \"boringssl_ssl_tests\": \"00a62f270fb79d9ccfb2e22541df8e4d97166e88\", \"browser_tests\": \"d9e804bf7da6eb61d2e81d1daf270301e83679a4\", \"capture_unittests\": \"5cbc0d35877ba233e1a8545b59e645b12deb5189\", \"cast_unittests\": \"8b4c21270337eb0447a47c1f5c625e21ae7e44ed\", \"cc_unittests\": \"50964f3c7fbf4a3ade28c7a79e577b81720ce2d7\", \"chrome_app_unittests\": \"0854acce0752abfbf251ff64fdc6963cef63702d\", \"chromedriver_unittests\": \"45e4ff165951b89a171779243117651ac08c2230\", \"chromeos_components_unittests\": \"0937d445705b5bce979fa85f19cae5e2a4a9af53\", \"chromeos_unittests\": \"b8a49874125c3c0d54751c9831aaeca25765c9b9\", \"components_browsertests\": \"b9a25207dfa15925f51cbdcae947ac9a49ac39bf\", \"components_unittests\": \"a74157dd8bc920d10795c28dcccdc800b0bcf159\", \"compositor_unittests\": \"00b5b3241e9aff6f17640acf64073b501e03b019\", \"content_browsertests\": \"01305f4bc82baeb15f5cdbf2e98463bc75053ea5\", \"content_unittests\": \"aaefa3d9f54316350f8b05f05f25c59b8449c8c2\", \"crashpad_tests\": \"df27c9ad043067655bb286e5eecb02cd9105e3af\", \"crypto_unittests\": \"caa4501fd298e79916de45aca449929ce2ac5f5f\", \"dbus_unittests\": \"11f0883ab1021f14cff9e9f3d835c33b2d20a5b3\", \"device_unittests\": \"64ae21c753e1035dbc6134d703e5d43cd37ab275\", \"display_unittests\": \"f73458485bfcf75d1ab4492c6c2a6f73f14ee0db\", \"events_unittests\": \"8877c900c5a1c477558e1710723bbf49d8cd6f27\", \"exo_unittests\": \"fe172d234dc891295134962bd5c0a503a3ee932c\", \"extensions_browsertests\": \"b320dc0412dfb49ef4462a14c3b2b6316d2ff4fc\", \"extensions_unittests\": \"a65269c1a013f18a9b97ba0ad0638acf84f77f19\", \"filesystem_service_unittests\": \"6574df85cb2590a8b4a1281d52dcfa877a34b4ac\", \"gcm_unit_tests\": \"e7cb6bbf84c9a59f7d274906cb2c9776c9694987\", \"gfx_unittests\": \"9a08223f92a226e1a93aacad076f6c68285e2f6f\", \"gin_unittests\": \"66a5bf32922395d76412bc39d864e8447bdd243a\", \"gl_unittests_ozone\": \"31d1209a07b6d006ed4b68bcb0a18d5c183fb286\", \"google_apis_unittests\": \"bb594e7839120dce470ee43094b357dc7a44bb8e\", \"gpu_unittests\": \"6d3a85c2ef25d0b3be87fb5b28f2948e1438c5f0\", \"gwp_asan_unittests\": \"bf0b2ec54d6c52b2740cb7992f8b6121ada5ab39\", \"interactive_ui_tests\": \"b8bffee79075ee7bf8956f0e75af21d0c97fee82\", \"ipc_tests\": \"17a1622f73eb5e69c054f52fcee6076d8f06d844\", \"jingle_unittests\": \"0ba64b318a10767de47e985fdf1742c13147af5e\", \"keyboard_unittests\": \"314a3969bb5ec5e7219f5f8478f81ec48755950c\", \"latency_unittests\": \"1698890457f7c85c9fcbfdbff649f575cb85b1fe\", \"libjingle_xmpp_unittests\": \"370b0441de1aab8efce4670b10752f3ed130af09\", \"liburlpattern_unittests\": \"36fa88f70a2a17d4ebe8195b39c581f5ea87d2e3\", \"media_blink_unittests\": \"5eda41adf98c2ea164803c24142862b5f5545416\", \"media_unittests\": \"94df1b8db2df94b03ba3802698ea03fd7a0fd92f\", \"message_center_unittests\": \"344e8f7501c577396dc96b378256db37d7f22e17\", \"midi_unittests\": \"ce86fd425d02058078c9f1ce17307832cfb05911\", \"mojo_core_unittests\": \"0d917f48ff8dd2a4dccf8f29b7f21a753778ec6a\", \"mojo_unittests\": \"9ccd5c9c2a454e4d25b3cfb6d4071a934f62cd42\", \"nacl_helper_nonsfi_unittests\": \"0eaeb91bae2bf58634081cb8befcd381a73f8fb4\", \"nacl_loader_unittests\": \"b8e226e51ff9425a0bdeebeabd63b134e713a34c\", \"native_theme_unittests\": \"e3c3ced17999fd3b7d2715439ca7fc7cffda44fd\", \"net_unittests\": \"d89f9646870a17fbcefe9db0fb9a5cc03eb82edf\", \"ozone_gl_unittests\": \"2ca3265285c0bb751e000f7e0c7f8030a1c19ee2\", \"ozone_unittests\": \"c079dd36364c43c5ab168f7e962463b74dfb951b\", \"ozone_x11_unittests\": \"25c5de230e9437530592da23cd476309d89a9cf0\", \"pdf_unittests\": \"805d5b0f7a06ed1399ec9ad05217025ae1041e0f\", \"perfetto_unittests\": \"4ea048911e54c0fb68f0fd1d6c5074c429a470f4\", \"ppapi_unittests\": \"7c6910eb7848181996bc3515e2320c0fcf94491b\", \"printing_unittests\": \"4298494fc30168c9aea06f2e541ed1b373d30442\", \"remoting_unittests\": \"645fb3e75aeed4b2bd64b8f063cc779e43d154a0\", \"sandbox_linux_unittests\": \"d0d8389b6d39ffbfca9904bc1d7a7f0b930e3b41\", \"service_manager_unittests\": \"ef8be14f98bde09745e23ec0adaefb50233b2cc8\", \"services_unittests\": \"4021abadf9e47715da97607da57308389061eaeb\", \"shell_dialogs_unittests\": \"6176f4a3f0d1c4f474ba95de11a10e8fbeeba922\", \"skia_unittests\": \"2feb62f445fb60eed8e54284bd182b6764a2847e\", \"snapshot_unittests\": \"80a0a367ea49670a0c5e8d5a07b47fea2528888c\", \"sql_unittests\": \"743413b0052740168f365efdf9a99fc74d3c3957\", \"storage_unittests\": \"7fd5a4421309c3a94322648e17033759b161b1d8\", \"sync_integration_tests\": \"48996f0a1ed3cf4a2f37b8b1ae39712b68206068\", \"traffic_annotation_auditor_unittests\": \"2ea85bfcc50f78d11d27c8e9391a3e4c1718d686\", \"ui_base_unittests\": \"35b5a7efdb7fed1c051ce8e29bba5ab1078d0fc4\", \"ui_chromeos_unittests\": \"1ef3960df780983e39ecf65ea89ae8b9e4f22a88\", \"ui_touch_selection_unittests\": \"765186bd01a87f06abac57a256177e872309806c\", \"unit_tests\": \"0d8caac8c291f4df10f26da11edb5dea9d88edaa\", \"url_unittests\": \"b35caf23e62217c2537722f52f1fd4c1a4ebdccb\", \"usage_time_limit_unittests\": \"c8e8b5b3dff262ecc2a27d2b529d042322456cb2\", \"views_unittests\": \"b8500679a92ca21411e7d1ffbe1b91f25e842e2c\", \"viz_unittests\": \"1040bd188c7f596ccd8652df30d2c134ee27f6e4\", \"wm_unittests\": \"aa899f60fb903d5835f424ad9a5a46768860ccca\", \"wtf_unittests\": \"6f837b9639c0a1d0bfe3932565961c9874d48555\", \"zlib_unittests\": \"6cade0633a389e7216c5591d021b4797ec842415\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093d924ecb526dae9a1dcf9db4725f8944eec2b4c0f2ddc6c2ac4a04802f7f15_v2\", \"builder_321a2ce955953920551fc69856a295b9c48a1a2350c0055b827d09f10d75e261_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_51829829c31fbaf3768e3309e640f1ed37e0867e138bde8c875431bcab07adc2_v2\", \"builder_8afdcfef4ae6fecf44bdc59bc36ab1bd30dfc75b00b262fd5e6b3421af127659_v2\", \"builder_8f7e40299f74ff9d94767563834f98f87bf45cac7401cd036aab5fd865cb3b58_v2\", \"builder_b624744545b53f30069a9e0f9d655dd80cb0688eb6f8753c5d4d1f02e2478691_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-19-g34z\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5632-2e614e1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605630736291786",
"status": "COMPLETED",
"status_changed_ts": "1605636866294788",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21356",
"builder:linux-chromeos-dbg",
"buildset:commit/git/269f716102142b6e73fa85b4a818432cac79855c",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/269f716102142b6e73fa85b4a818432cac79855c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028797925975704608",
"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/8863367863887001952/+/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:4fefde3cea6bfb10",
"user_agent:luci-scheduler"
],
"updated_ts": "1605636866303367",
"url": "https://ci.chromium.org/b/8863367863887001952",
"utcnow_ts": "1605636867197083"
}
}
[18:14:27.220] Invocation finished in 1h42m15.0374386s with status SUCCEEDED