[08:16:21.083] New invocation is queued and will start shortly
[08:16:22.621] Starting the invocation (attempt 1)
[08:16:22.663] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:16:22.664] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:16:22.664] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023846289130365408",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"e05e939efaefb404911a210173a1f26e223bf7e8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023846289130365408",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/e05e939efaefb404911a210173a1f26e223bf7e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e05e939efaefb404911a210173a1f26e223bf7e8",
"gitiles_ref:refs/heads/master"
]
}
[08:16:25.360] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610352983664019",
"id": "8858416225759323632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e05e939efaefb404911a210173a1f26e223bf7e8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610352985099283",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22147",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e05e939efaefb404911a210173a1f26e223bf7e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e05e939efaefb404911a210173a1f26e223bf7e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023846289130365408",
"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/8858416225759323632/+/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": "1610352985099798",
"url": "https://ci.chromium.org/b/8858416225759323632",
"utcnow_ts": "1610352985348211"
}
}
[08:16:25.360] Task URL: https://ci.chromium.org/b/8858416225759323632
[08:16:25.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:2:0) after 1m0s
[08:17:45.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:2:0)
[08:17:45.620] Timer tick, asking Buildbucket for the build status
[08:17:45.726] Build 8858416225759323632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:45.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:3:0) after 1m0s
[08:18:46.435] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:3:0)
[08:18:46.435] Timer tick, asking Buildbucket for the build status
[08:18:46.664] Build 8858416225759323632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:46.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:4:0) after 1m0s
[08:19:46.960] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:4:0)
[08:19:46.960] Timer tick, asking Buildbucket for the build status
[08:19:47.077] Build 8858416225759323632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:19:47.077] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:5:0) after 1m0s
[08:20:47.238] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:5:0)
[08:20:47.238] Timer tick, asking Buildbucket for the build status
[08:20:47.308] Build 8858416225759323632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:20:47.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:6:0) after 1m0s
[08:21:07.818] Received PubSub notification, asking Buildbucket for the build status
[08:21:07.900] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:47.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:6:0)
[08:21:47.928] Timer tick, asking Buildbucket for the build status
[08:21:48.101] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:48.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:8:0) after 1m0s
[08:22:48.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:8:0)
[08:22:48.325] Timer tick, asking Buildbucket for the build status
[08:22:48.436] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:48.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:9:0) after 1m0s
[08:23:48.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:9:0)
[08:23:48.667] Timer tick, asking Buildbucket for the build status
[08:23:48.724] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:48.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:10:0) after 1m0s
[08:24:49.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:10:0)
[08:24:49.038] Timer tick, asking Buildbucket for the build status
[08:24:49.197] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:49.197] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:11:0) after 1m0s
[08:25:49.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:11:0)
[08:25:49.282] Timer tick, asking Buildbucket for the build status
[08:25:49.491] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:49.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:12:0) after 1m0s
[08:26:49.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:12:0)
[08:26:49.672] Timer tick, asking Buildbucket for the build status
[08:26:50.063] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:50.063] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:13:0) after 1m0s
[08:27:51.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:13:0)
[08:27:51.058] Timer tick, asking Buildbucket for the build status
[08:27:51.244] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:51.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:14:0) after 1m0s
[08:28:51.263] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:14:0)
[08:28:51.263] Timer tick, asking Buildbucket for the build status
[08:28:51.329] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:51.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:15:0) after 1m0s
[08:29:51.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:15:0)
[08:29:51.413] Timer tick, asking Buildbucket for the build status
[08:29:51.547] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:51.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:16:0) after 1m0s
[08:30:51.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:16:0)
[08:30:51.548] Timer tick, asking Buildbucket for the build status
[08:30:51.803] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:51.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:17:0) after 1m0s
[08:31:51.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:17:0)
[08:31:51.895] Timer tick, asking Buildbucket for the build status
[08:31:51.949] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:51.949] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:18:0) after 1m0s
[08:32:52.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:18:0)
[08:32:52.043] Timer tick, asking Buildbucket for the build status
[08:32:52.147] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:52.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:19:0) after 1m0s
[08:33:52.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:19:0)
[08:33:52.160] Timer tick, asking Buildbucket for the build status
[08:33:52.219] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:52.219] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:20:0) after 1m0s
[08:34:52.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:20:0)
[08:34:52.313] Timer tick, asking Buildbucket for the build status
[08:34:52.604] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:52.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:21:0) after 1m0s
[08:35:52.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:21:0)
[08:35:52.620] Timer tick, asking Buildbucket for the build status
[08:35:52.886] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:52.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:22:0) after 1m0s
[08:36:52.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:22:0)
[08:36:52.863] Timer tick, asking Buildbucket for the build status
[08:36:53.026] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:53.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:23:0) after 1m0s
[08:37:53.084] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:23:0)
[08:37:53.084] Timer tick, asking Buildbucket for the build status
[08:37:53.184] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:53.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:24:0) after 1m0s
[08:38:53.192] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:24:0)
[08:38:53.192] Timer tick, asking Buildbucket for the build status
[08:38:53.347] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:53.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:25:0) after 1m0s
[08:39:53.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:25:0)
[08:39:53.407] Timer tick, asking Buildbucket for the build status
[08:39:53.456] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:53.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:26:0) after 1m0s
[08:40:53.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:26:0)
[08:40:53.544] Timer tick, asking Buildbucket for the build status
[08:40:53.654] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:53.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:27:0) after 1m0s
[08:41:53.722] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:27:0)
[08:41:53.722] Timer tick, asking Buildbucket for the build status
[08:41:53.786] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:53.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:28:0) after 1m0s
[08:42:53.826] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:28:0)
[08:42:53.826] Timer tick, asking Buildbucket for the build status
[08:42:53.915] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:53.915] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:29:0) after 1m0s
[08:43:53.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:29:0)
[08:43:53.944] Timer tick, asking Buildbucket for the build status
[08:43:54.006] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:54.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:30:0) after 1m0s
[08:44:54.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:30:0)
[08:44:54.179] Timer tick, asking Buildbucket for the build status
[08:44:54.400] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:54.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:31:0) after 1m0s
[08:45:54.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:31:0)
[08:45:54.515] Timer tick, asking Buildbucket for the build status
[08:45:54.571] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:54.571] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:32:0) after 1m0s
[08:46:54.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:32:0)
[08:46:54.667] Timer tick, asking Buildbucket for the build status
[08:46:54.995] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:54.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:33:0) after 1m0s
[08:47:55.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:33:0)
[08:47:55.038] Timer tick, asking Buildbucket for the build status
[08:47:55.175] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:55.175] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:34:0) after 1m0s
[08:48:55.247] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:34:0)
[08:48:55.247] Timer tick, asking Buildbucket for the build status
[08:48:55.519] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:55.520] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:35:0) after 1m0s
[08:49:55.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:35:0)
[08:49:55.552] Timer tick, asking Buildbucket for the build status
[08:49:55.624] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:55.624] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:36:0) after 1m0s
[08:50:55.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:36:0)
[08:50:55.636] Timer tick, asking Buildbucket for the build status
[08:50:55.692] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:55.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:37:0) after 1m0s
[08:51:55.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:37:0)
[08:51:55.780] Timer tick, asking Buildbucket for the build status
[08:51:55.863] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:55.863] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:38:0) after 1m0s
[08:52:55.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:38:0)
[08:52:55.840] Timer tick, asking Buildbucket for the build status
[08:52:56.035] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:39:0) after 1m0s
[08:53:56.038] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:39:0)
[08:53:56.038] Timer tick, asking Buildbucket for the build status
[08:53:56.101] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:56.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:40:0) after 1m0s
[08:54:56.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:40:0)
[08:54:56.118] Timer tick, asking Buildbucket for the build status
[08:54:56.184] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:56.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:41:0) after 1m0s
[08:55:56.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:41:0)
[08:55:56.204] Timer tick, asking Buildbucket for the build status
[08:55:56.336] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:56.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:42:0) after 1m0s
[08:56:56.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:42:0)
[08:56:56.407] Timer tick, asking Buildbucket for the build status
[08:56:56.471] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:56.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:43:0) after 1m0s
[08:57:56.493] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:43:0)
[08:57:56.493] Timer tick, asking Buildbucket for the build status
[08:57:56.613] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:56.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:44:0) after 1m0s
[08:58:56.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:44:0)
[08:58:56.645] Timer tick, asking Buildbucket for the build status
[08:58:56.722] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:56.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:45:0) after 1m0s
[08:59:56.746] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:45:0)
[08:59:56.746] Timer tick, asking Buildbucket for the build status
[08:59:56.802] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:56.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:46:0) after 1m0s
[09:00:56.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:46:0)
[09:00:56.891] Timer tick, asking Buildbucket for the build status
[09:00:56.948] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:56.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:47:0) after 1m0s
[09:01:56.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:47:0)
[09:01:56.962] Timer tick, asking Buildbucket for the build status
[09:01:57.381] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:57.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:48:0) after 1m0s
[09:02:57.469] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:48:0)
[09:02:57.469] Timer tick, asking Buildbucket for the build status
[09:02:57.529] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:57.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:49:0) after 1m0s
[09:03:57.629] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:49:0)
[09:03:57.629] Timer tick, asking Buildbucket for the build status
[09:03:57.685] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:57.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:50:0) after 1m0s
[09:04:57.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:50:0)
[09:04:57.741] Timer tick, asking Buildbucket for the build status
[09:04:57.800] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:04:57.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:51:0) after 1m0s
[09:05:57.811] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:51:0)
[09:05:57.811] Timer tick, asking Buildbucket for the build status
[09:05:57.873] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:05:57.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:52:0) after 1m0s
[09:06:57.945] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:52:0)
[09:06:57.945] Timer tick, asking Buildbucket for the build status
[09:06:58.123] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:06:58.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:53:0) after 1m0s
[09:07:58.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:53:0)
[09:07:58.246] Timer tick, asking Buildbucket for the build status
[09:07:58.346] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:07:58.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:54:0) after 1m0s
[09:08:58.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:54:0)
[09:08:58.417] Timer tick, asking Buildbucket for the build status
[09:08:58.531] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:08:58.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:55:0) after 1m0s
[09:09:58.609] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:55:0)
[09:09:58.609] Timer tick, asking Buildbucket for the build status
[09:09:58.758] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:09:58.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:56:0) after 1m0s
[09:10:58.830] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:56:0)
[09:10:58.830] Timer tick, asking Buildbucket for the build status
[09:10:59.115] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:10:59.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:57:0) after 1m0s
[09:11:59.145] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:57:0)
[09:11:59.145] Timer tick, asking Buildbucket for the build status
[09:11:59.244] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:11:59.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:58:0) after 1m0s
[09:12:59.352] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:58:0)
[09:12:59.352] Timer tick, asking Buildbucket for the build status
[09:12:59.422] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:12:59.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:59:0) after 1m0s
[09:13:59.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:59:0)
[09:13:59.500] Timer tick, asking Buildbucket for the build status
[09:13:59.632] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:13:59.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:60:0) after 1m0s
[09:14:59.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:60:0)
[09:14:59.665] Timer tick, asking Buildbucket for the build status
[09:14:59.774] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:14:59.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:61:0) after 1m0s
[09:15:59.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:61:0)
[09:15:59.869] Timer tick, asking Buildbucket for the build status
[09:16:00.143] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:16:00.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:62:0) after 1m0s
[09:17:00.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:62:0)
[09:17:00.370] Timer tick, asking Buildbucket for the build status
[09:17:00.847] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:17:00.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:63:0) after 1m0s
[09:18:00.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:63:0)
[09:18:00.868] Timer tick, asking Buildbucket for the build status
[09:18:00.963] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:18:00.963] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:64:0) after 1m0s
[09:19:01.245] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:64:0)
[09:19:01.245] Timer tick, asking Buildbucket for the build status
[09:19:01.414] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:19:01.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:65:0) after 1m0s
[09:20:01.567] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:65:0)
[09:20:01.567] Timer tick, asking Buildbucket for the build status
[09:20:01.684] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:20:01.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:66:0) after 1m0s
[09:21:01.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:66:0)
[09:21:01.741] Timer tick, asking Buildbucket for the build status
[09:21:01.957] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:21:01.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:67:0) after 1m0s
[09:22:02.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:67:0)
[09:22:02.072] Timer tick, asking Buildbucket for the build status
[09:22:02.430] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:22:02.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:68:0) after 1m0s
[09:23:02.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:68:0)
[09:23:02.486] Timer tick, asking Buildbucket for the build status
[09:23:02.814] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:23:02.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:69:0) after 1m0s
[09:24:02.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:69:0)
[09:24:02.868] Timer tick, asking Buildbucket for the build status
[09:24:03.143] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:24:03.143] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:70:0) after 1m0s
[09:25:03.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:70:0)
[09:25:03.171] Timer tick, asking Buildbucket for the build status
[09:25:03.310] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:25:03.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:71:0) after 1m0s
[09:26:03.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:71:0)
[09:26:03.403] Timer tick, asking Buildbucket for the build status
[09:26:03.518] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:26:03.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:72:0) after 1m0s
[09:27:03.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:72:0)
[09:27:03.657] Timer tick, asking Buildbucket for the build status
[09:27:04.222] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:27:04.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:73:0) after 1m0s
[09:28:04.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:73:0)
[09:28:04.287] Timer tick, asking Buildbucket for the build status
[09:28:04.420] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:28:04.420] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:74:0) after 1m0s
[09:29:04.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:74:0)
[09:29:04.869] Timer tick, asking Buildbucket for the build status
[09:29:05.012] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:29:05.012] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:75:0) after 1m0s
[09:30:05.341] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:75:0)
[09:30:05.341] Timer tick, asking Buildbucket for the build status
[09:30:05.646] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:30:05.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:76:0) after 1m0s
[09:31:06.185] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:76:0)
[09:31:06.185] Timer tick, asking Buildbucket for the build status
[09:31:06.262] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:31:06.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:77:0) after 1m0s
[09:32:06.357] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:77:0)
[09:32:06.357] Timer tick, asking Buildbucket for the build status
[09:32:06.489] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:32:06.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:78:0) after 1m0s
[09:33:06.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:78:0)
[09:33:06.570] Timer tick, asking Buildbucket for the build status
[09:33:06.635] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:33:06.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:79:0) after 1m0s
[09:34:06.659] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:79:0)
[09:34:06.659] Timer tick, asking Buildbucket for the build status
[09:34:06.825] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:34:06.825] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:80:0) after 1m0s
[09:35:06.967] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:80:0)
[09:35:06.967] Timer tick, asking Buildbucket for the build status
[09:35:07.093] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:35:07.093] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:81:0) after 1m0s
[09:36:07.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:81:0)
[09:36:07.172] Timer tick, asking Buildbucket for the build status
[09:36:07.259] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:36:07.259] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:82:0) after 1m0s
[09:37:07.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:82:0)
[09:37:07.479] Timer tick, asking Buildbucket for the build status
[09:37:07.584] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:37:07.584] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:83:0) after 1m0s
[09:38:07.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:83:0)
[09:38:07.665] Timer tick, asking Buildbucket for the build status
[09:38:07.763] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:38:07.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:84:0) after 1m0s
[09:39:07.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:84:0)
[09:39:07.955] Timer tick, asking Buildbucket for the build status
[09:39:08.192] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:39:08.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:85:0) after 1m0s
[09:40:08.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:85:0)
[09:40:08.389] Timer tick, asking Buildbucket for the build status
[09:40:08.453] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:40:08.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:86:0) after 1m0s
[09:41:08.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:86:0)
[09:41:08.909] Timer tick, asking Buildbucket for the build status
[09:41:09.079] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:41:09.079] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:87:0) after 1m0s
[09:42:09.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:87:0)
[09:42:09.239] Timer tick, asking Buildbucket for the build status
[09:42:09.354] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:42:09.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:88:0) after 1m0s
[09:43:09.522] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:88:0)
[09:43:09.522] Timer tick, asking Buildbucket for the build status
[09:43:09.620] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:43:09.620] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:89:0) after 1m0s
[09:44:09.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:89:0)
[09:44:09.691] Timer tick, asking Buildbucket for the build status
[09:44:09.878] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:44:09.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:90:0) after 1m0s
[09:45:09.931] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:90:0)
[09:45:09.931] Timer tick, asking Buildbucket for the build status
[09:45:09.995] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:45:09.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:91:0) after 1m0s
[09:46:10.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:91:0)
[09:46:10.092] Timer tick, asking Buildbucket for the build status
[09:46:10.320] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:46:10.320] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:92:0) after 1m0s
[09:47:10.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:92:0)
[09:47:10.414] Timer tick, asking Buildbucket for the build status
[09:47:10.608] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:47:10.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:93:0) after 1m0s
[09:48:10.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:93:0)
[09:48:10.666] Timer tick, asking Buildbucket for the build status
[09:48:10.918] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:48:10.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:94:0) after 1m0s
[09:49:10.944] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:94:0)
[09:49:10.944] Timer tick, asking Buildbucket for the build status
[09:49:11.531] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:49:11.531] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:95:0) after 1m0s
[09:50:11.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:95:0)
[09:50:11.637] Timer tick, asking Buildbucket for the build status
[09:50:11.717] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:50:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:96:0) after 1m0s
[09:51:11.733] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:96:0)
[09:51:11.733] Timer tick, asking Buildbucket for the build status
[09:51:11.817] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:51:11.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:97:0) after 1m0s
[09:52:11.872] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:97:0)
[09:52:11.872] Timer tick, asking Buildbucket for the build status
[09:52:12.044] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:52:12.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:98:0) after 1m0s
[09:53:12.095] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:98:0)
[09:53:12.095] Timer tick, asking Buildbucket for the build status
[09:53:13.315] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:53:13.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:99:0) after 1m0s
[09:54:13.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:99:0)
[09:54:13.343] Timer tick, asking Buildbucket for the build status
[09:54:13.840] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:54:13.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:100:0) after 1m0s
[09:55:13.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:100:0)
[09:55:13.968] Timer tick, asking Buildbucket for the build status
[09:55:14.347] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:55:14.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:101:0) after 1m0s
[09:56:14.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:101:0)
[09:56:14.471] Timer tick, asking Buildbucket for the build status
[09:56:14.731] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:56:14.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:102:0) after 1m0s
[09:57:14.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:102:0)
[09:57:14.801] Timer tick, asking Buildbucket for the build status
[09:57:15.025] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:57:15.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:103:0) after 1m0s
[09:58:15.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:103:0)
[09:58:15.056] Timer tick, asking Buildbucket for the build status
[09:58:15.496] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:58:15.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:104:0) after 1m0s
[09:59:15.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:104:0)
[09:59:15.510] Timer tick, asking Buildbucket for the build status
[09:59:15.574] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:59:15.574] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:105:0) after 1m0s
[10:00:15.561] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:105:0)
[10:00:15.561] Timer tick, asking Buildbucket for the build status
[10:00:15.680] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:00:15.680] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:106:0) after 1m0s
[10:01:15.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:106:0)
[10:01:15.863] Timer tick, asking Buildbucket for the build status
[10:01:15.957] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:01:15.957] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:107:0) after 1m0s
[10:02:16.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:107:0)
[10:02:16.767] Timer tick, asking Buildbucket for the build status
[10:02:16.893] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:02:16.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:108:0) after 1m0s
[10:03:16.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:108:0)
[10:03:16.878] Timer tick, asking Buildbucket for the build status
[10:03:17.024] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:03:17.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:109:0) after 1m0s
[10:04:17.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:109:0)
[10:04:17.051] Timer tick, asking Buildbucket for the build status
[10:04:17.304] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:04:17.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:110:0) after 1m0s
[10:05:17.371] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:110:0)
[10:05:17.371] Timer tick, asking Buildbucket for the build status
[10:05:17.539] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:05:17.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:111:0) after 1m0s
[10:06:17.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:111:0)
[10:06:17.558] Timer tick, asking Buildbucket for the build status
[10:06:18.031] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:06:18.031] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:112:0) after 1m0s
[10:07:18.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:112:0)
[10:07:18.096] Timer tick, asking Buildbucket for the build status
[10:07:18.230] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:07:18.230] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:113:0) after 1m0s
[10:08:18.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:113:0)
[10:08:18.329] Timer tick, asking Buildbucket for the build status
[10:08:18.392] Build 8858416225759323632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:08:18.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023846289130365408:114:0) after 1m0s
[10:08:41.854] Received PubSub notification, asking Buildbucket for the build status
[10:08:41.922] Build 8858416225759323632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[10:08:41.922] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610359720600900",
"created_by": "project:chromium",
"created_ts": "1610352983664019",
"id": "8858416225759323632",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"e05e939efaefb404911a210173a1f26e223bf7e8\"}}",
"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\": \"e05e939efaefb404911a210173a1f26e223bf7e8\", \"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-72-w0e6\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22147, \"got_angle_revision\": \"0b90eef09f607336330f318bc8e65fa981634160\", \"got_dawn_revision\": \"3a0405597374c9ae12fb93e33aac35826455a958\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"e05e939efaefb404911a210173a1f26e223bf7e8\", \"got_revision_cp\": \"refs/heads/master@{#841928}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"348ba200aa29d5b3a36d696d48d8f619e055219f\", \"got_v8_revision\": \"5d60a181de0863d8d00ae42ec0ee3521f51b501a\", \"got_v8_revision_cp\": \"refs/heads/8.9.229@{#1}\", \"got_webrtc_revision\": \"952be209246ab9ba702159cb246eac0e232b15ae\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32931}\", \"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\": \"e05e939efaefb404911a210173a1f26e223bf7e8\", \"swarm_hashes_refs/heads/master(at){#841928}_without_patch\": {\"absl_hardening_tests\": \"44fc57ec55baf0c5dd4f92897124fb9183359132\", \"accessibility_unittests\": \"dade46de349070c270624ab786b59d99c7efaf0e\", \"angle_unittests\": \"990e7ff84167edf4e3d72d69b02e024298d35536\", \"app_list_unittests\": \"bccea73c29f501dbda5a08d0bc3613009e6a3a88\", \"app_shell_unittests\": \"63e7bf15e3802c919ca3ead721c3c5ab24ae504b\", \"ash_unittests\": \"6ebd458eb277941ba1b86ae96d52e31ccd3320f3\", \"aura_unittests\": \"9c02d2c02aae7b8031497be9c8c97703a3f79f2c\", \"base_unittests\": \"8a36fd67c4132e71a9892c73b72246f443bbca93\", \"base_util_unittests\": \"5490b51f3b0baed440540a57687d2d3b4472da25\", \"blink_common_unittests\": \"fddf89e10f77fc612623ef58e0d96ed6f0202f65\", \"blink_fuzzer_unittests\": \"cb927590a371485c375d872a46933ac1f784f77b\", \"blink_heap_unittests\": \"1d82df892cbabc52dd3d43bdccabd1bce2f09ae6\", \"blink_platform_unittests\": \"7b8868843fe5a5733e8b34553f1d7a25efacb411\", \"blink_unittests\": \"3c26437ab3f175e0ac604226aa9baa082c5826d1\", \"boringssl_crypto_tests\": \"286e5bba7ece62068f3af244c56b6131332fb1ef\", \"boringssl_ssl_tests\": \"b44e6eb080e4d6f73f513fe122cd436a638429aa\", \"browser_tests\": \"7a74614f36acad63bac3a74bbf6ca8321275fc35\", \"capture_unittests\": \"c6bccf76ae9c4ab863eb48e538f903e646fdd858\", \"cast_unittests\": \"6ec5bb6828aad815769e34ac380ded8a619860f3\", \"cc_unittests\": \"71f4bcf50a5800d8580a52630438236696198595\", \"chrome_app_unittests\": \"196ca1e3ebdb84d617ce9266fa2b72c7e6f7f875\", \"chromedriver_unittests\": \"747caba3bec9d6fdf81a0d32d1d259d8df1bde68\", \"chromeos_components_unittests\": \"f1ff8004d5a15f099f247971fae9f941444fe4d9\", \"chromeos_unittests\": \"193928b0071feed0edfd0b11673f4f42e8fde8d2\", \"components_browsertests\": \"152a119a854e283e6de5544bb66c2046e5f40fd1\", \"components_unittests\": \"ae3616bfb6a7f4dcac9ea524dc38083a1c5be8b8\", \"compositor_unittests\": \"1c2282ac89d244f1587208b0cb8638d3511822a1\", \"content_browsertests\": \"77891ab5cf074efecb0afcff02f48c93bd23706b\", \"content_unittests\": \"3ded6bd95cca1bbcc6e68dc948fae15d0564a3b9\", \"crashpad_tests\": \"7ba89622f0b3d8a200b9cac87ae1a1ec284d64e1\", \"crypto_unittests\": \"026911c2875ed226ca2a0790cc81642cb81e7df6\", \"dbus_unittests\": \"659f6b6c761ef02e79a85ca8f8444d263cae0ff0\", \"device_unittests\": \"518a3608ea86811e6c2732fbeac935ae604ad468\", \"display_unittests\": \"eacb6df92fcd034d8c6fd7b72ca17328b00017a3\", \"events_unittests\": \"49aa8084fc7f8a1b9fd9603657c66172bf88a88d\", \"exo_unittests\": \"a057099fe924f0eec3d7579951a694598ecd04e9\", \"extensions_browsertests\": \"4943c3e723a41ea7425a731aa2820aca959da67a\", \"extensions_unittests\": \"6e0fb9b6f6ee473000a23a4b5879b475430ed198\", \"filesystem_service_unittests\": \"535704a5e01f0b4dc42dd25c0a07f090a68d7c4f\", \"gcm_unit_tests\": \"4934797efb0ae45a576af0f9bebaceaf0aec0785\", \"gfx_unittests\": \"3079632f9402996888921af9e843e8a6b508c28a\", \"gin_unittests\": \"6b276f7859435ae4f13a2c652b5727f9b6639922\", \"gl_unittests_ozone\": \"e18d67cc24f67d6452e162b3a6be247fc6a771d6\", \"google_apis_unittests\": \"c863fd5ff78f9ab1b244cf58bd1729e93daf6ac7\", \"gpu_unittests\": \"d0efd10ed74cbcb6acab77aaa2242fb363b311b8\", \"gwp_asan_unittests\": \"e8796f591c73912fce9bec8d86cac00633ebd623\", \"interactive_ui_tests\": \"eec5f6967314301f9109d995ad90d5579800d20d\", \"ipc_tests\": \"a3eeada68512c57dfa0850d85074cceda4baf818\", \"jingle_unittests\": \"89827577b1a290311cfa1c5119b0df4da81378b7\", \"keyboard_unittests\": \"f0cce94440048f34c1337c0715f877bad56fe404\", \"latency_unittests\": \"0361473c934b199669bccdafa231ad40f46a5ce3\", \"libjingle_xmpp_unittests\": \"f7348af02e7a91a1b606d949d93bbb8e8da97b52\", \"liburlpattern_unittests\": \"75ef4e41d67919594f703792ee74c1201e4d2175\", \"media_blink_unittests\": \"9a86187eb046eb4165c8929b4803e96647c56598\", \"media_unittests\": \"b6626e7d8b488d4a4d8b4d4962b3db43137dbcb2\", \"message_center_unittests\": \"dbca891d664b93da27d70d0087a58002680a760a\", \"midi_unittests\": \"148ad0ed7ff8831f22d7e6557fe001a6f5e31a7b\", \"mojo_core_unittests\": \"01fbfc653851a70e0efc826e452a744908ba9882\", \"mojo_unittests\": \"5170861adc79ec5eef5bd6a4bbf9bf768becc199\", \"nacl_helper_nonsfi_unittests\": \"7afe5f4ab6a1decf3358920a803e8985eeee9cc8\", \"nacl_loader_unittests\": \"1f8f6c2892ad10831dced659604a901bcea4d2bf\", \"native_theme_unittests\": \"6fbbfffc2e78ea7e640a4b6b7092c2c32b16c3b6\", \"net_unittests\": \"20aa9813a9e566403572456db915bc069b69d0fa\", \"ozone_gl_unittests\": \"8a293ae6610b860ce9b7b4f4389e3aeea72bc481\", \"ozone_unittests\": \"c494caa9c3e9a69942ed22f57d2d9481878bb75f\", \"ozone_x11_unittests\": \"257c8d7fa098bdaa14ba68b1580ac930153a9677\", \"pdf_unittests\": \"682fed838995fbec4eb6f7973da990799045f385\", \"perfetto_unittests\": \"c141ad8e959e87fbb1b9167fe5739711385c7507\", \"ppapi_unittests\": \"f93628f4ea2d32fc49c0676ecc2d3b5577242725\", \"printing_unittests\": \"1b1a370e4a043ed01dc9d54aa7a73ad0206449ff\", \"remoting_unittests\": \"4ae5c66d4927229ebaaf03c6cba737f886394b41\", \"sandbox_linux_unittests\": \"f146eaa2113754448e5c98a5be0b33b2f918a503\", \"service_manager_unittests\": \"5ddcb501ba76aa75fd646b18f45a81f2857a3773\", \"services_unittests\": \"d56d52ef324ecb87bff0afc2d5211bea7e23c24a\", \"shell_dialogs_unittests\": \"1fe6a59d8aefede1c89ef7abbe62c8b391472d8d\", \"shell_encryption_unittests\": \"dbec24febddb2d76ffc00d1066b8b4137611d335\", \"skia_unittests\": \"6b062e7b7e1cf088936be79f3eaaa6363eb550e9\", \"snapshot_unittests\": \"b5078d5644990bfbf84e50e328f1d0c478cf913a\", \"sql_unittests\": \"4714595228179a83d99ef8cbe298b0b30f262a28\", \"storage_unittests\": \"70cddd1e67b5d86c8666cb15816897d2a8db9718\", \"sync_integration_tests\": \"85a8607a2ac620a4768e4f5bd67d39b7439dda70\", \"traffic_annotation_auditor_unittests\": \"19f9650b4e0a0f53e010c37bab4c742a29f565ad\", \"ui_base_unittests\": \"7c2b1e784f04bd0e00173bde7916933a78c48c0c\", \"ui_chromeos_unittests\": \"81f2b2e1d93e96088c3ec767b2c7eac95ab16bdf\", \"ui_touch_selection_unittests\": \"67c3a1841fb56347bd0a997fec8418981010308a\", \"unit_tests\": \"65164a8ff9f1f64a0eca217332956d6c694e55b6\", \"url_unittests\": \"a39c30bb6aed39a4771f332f845e2139b87d644a\", \"usage_time_limit_unittests\": \"de4520a88283767ea6e35ede605f09133d36887b\", \"views_unittests\": \"fde232aaa5e1d44ed3cbc96315b76d5857333aae\", \"viz_unittests\": \"f08a9267eb9d2fea010343390d606d2cfd8b211c\", \"wm_unittests\": \"8bf52afbb7c01f1842f03ac58eb24f629ef5b419\", \"wtf_unittests\": \"ab6b9370490f6abc7cfee40329d8520579451477\", \"zlib_unittests\": \"d7ff0bb7b6662bdfc53d542ff270dc8fba274e31\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-72-w0e6\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610353267150990",
"status": "COMPLETED",
"status_changed_ts": "1610359720934036",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22147",
"builder:linux-chromeos-dbg",
"buildset:commit/git/e05e939efaefb404911a210173a1f26e223bf7e8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/e05e939efaefb404911a210173a1f26e223bf7e8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023846289130365408",
"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/8858416225759323632/+/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:5109568114f09210",
"user_agent:luci-scheduler"
],
"updated_ts": "1610359720937981",
"url": "https://ci.chromium.org/b/8858416225759323632",
"utcnow_ts": "1610359721913352"
}
}
[10:08:41.922] Invocation finished in 1h52m20.855789258s with status SUCCEEDED