[10:50:06.951] New invocation is queued and will start shortly
[10:50:08.424] Starting the invocation (attempt 1)
[10:50:08.467] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:50:08.469] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:50:08.469] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031084372427468112",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031084372427468112",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"gitiles_ref:refs/heads/master"
]
}
[10:50:10.155] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603450208606994",
"id": "8865654310019520784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603450209828679",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20977",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031084372427468112",
"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/8865654310019520784/+/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": "1603450209829792",
"url": "https://ci.chromium.org/b/8865654310019520784",
"utcnow_ts": "1603450210144556"
}
}
[10:50:10.155] Task URL: https://ci.chromium.org/b/8865654310019520784
[10:50:10.156] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:2:0) after 1m0s
[10:51:10.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:2:0)
[10:51:10.312] Timer tick, asking Buildbucket for the build status
[10:51:10.799] Build 8865654310019520784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:51:10.799] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:3:0) after 1m0s
[10:52:10.858] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:3:0)
[10:52:10.858] Timer tick, asking Buildbucket for the build status
[10:52:10.935] Build 8865654310019520784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:52:10.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:4:0) after 1m0s
[10:53:10.956] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:4:0)
[10:53:10.956] Timer tick, asking Buildbucket for the build status
[10:53:11.119] Build 8865654310019520784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:53:11.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:5:0) after 1m0s
[10:54:11.146] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:5:0)
[10:54:11.146] Timer tick, asking Buildbucket for the build status
[10:54:11.231] Build 8865654310019520784: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[10:54:11.231] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:6:0) after 1m0s
[10:55:04.302] Received PubSub notification, asking Buildbucket for the build status
[10:55:04.381] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:11.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:6:0)
[10:55:11.256] Timer tick, asking Buildbucket for the build status
[10:55:11.522] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:55:11.522] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:8:0) after 1m0s
[10:56:11.547] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:8:0)
[10:56:11.548] Timer tick, asking Buildbucket for the build status
[10:56:11.668] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:56:11.668] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:9:0) after 1m0s
[10:57:11.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:9:0)
[10:57:11.694] Timer tick, asking Buildbucket for the build status
[10:57:11.784] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:57:11.784] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:10:0) after 1m0s
[10:58:11.812] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:10:0)
[10:58:11.812] Timer tick, asking Buildbucket for the build status
[10:58:11.878] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:58:11.878] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:11:0) after 1m0s
[10:59:11.900] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:11:0)
[10:59:11.900] Timer tick, asking Buildbucket for the build status
[10:59:12.107] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[10:59:12.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:12:0) after 1m0s
[11:00:12.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:12:0)
[11:00:12.211] Timer tick, asking Buildbucket for the build status
[11:00:12.554] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:00:12.555] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:13:0) after 1m0s
[11:01:12.618] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:13:0)
[11:01:12.618] Timer tick, asking Buildbucket for the build status
[11:01:12.801] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:01:12.801] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:14:0) after 1m0s
[11:02:13.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:14:0)
[11:02:13.205] Timer tick, asking Buildbucket for the build status
[11:02:13.306] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:02:13.306] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:15:0) after 1m0s
[11:03:13.348] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:15:0)
[11:03:13.349] Timer tick, asking Buildbucket for the build status
[11:03:13.499] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:03:13.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:16:0) after 1m0s
[11:04:13.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:16:0)
[11:04:13.633] Timer tick, asking Buildbucket for the build status
[11:04:13.703] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:04:13.704] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:17:0) after 1m0s
[11:05:13.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:17:0)
[11:05:13.905] Timer tick, asking Buildbucket for the build status
[11:05:14.053] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:05:14.053] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:18:0) after 1m0s
[11:06:14.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:18:0)
[11:06:14.091] Timer tick, asking Buildbucket for the build status
[11:06:14.253] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:06:14.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:19:0) after 1m0s
[11:07:14.241] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:19:0)
[11:07:14.241] Timer tick, asking Buildbucket for the build status
[11:07:14.382] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:07:14.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:20:0) after 1m0s
[11:08:14.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:20:0)
[11:08:14.410] Timer tick, asking Buildbucket for the build status
[11:08:14.767] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:08:14.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:21:0) after 1m0s
[11:09:14.866] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:21:0)
[11:09:14.866] Timer tick, asking Buildbucket for the build status
[11:09:14.942] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:09:14.942] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:22:0) after 1m0s
[11:10:15.250] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:22:0)
[11:10:15.250] Timer tick, asking Buildbucket for the build status
[11:10:15.628] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:10:15.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:23:0) after 1m0s
[11:11:15.692] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:23:0)
[11:11:15.692] Timer tick, asking Buildbucket for the build status
[11:11:15.778] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:11:15.778] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:24:0) after 1m0s
[11:12:15.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:24:0)
[11:12:15.801] Timer tick, asking Buildbucket for the build status
[11:12:15.862] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:12:15.862] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:25:0) after 1m0s
[11:13:16.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:25:0)
[11:13:16.024] Timer tick, asking Buildbucket for the build status
[11:13:16.101] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:13:16.101] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:26:0) after 1m0s
[11:14:16.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:26:0)
[11:14:16.244] Timer tick, asking Buildbucket for the build status
[11:14:16.311] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:14:16.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:27:0) after 1m0s
[11:15:16.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:27:0)
[11:15:16.382] Timer tick, asking Buildbucket for the build status
[11:15:17.616] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:15:17.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:28:0) after 1m0s
[11:16:17.780] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:28:0)
[11:16:17.780] Timer tick, asking Buildbucket for the build status
[11:16:17.846] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:16:17.846] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:29:0) after 1m0s
[11:17:18.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:29:0)
[11:17:18.112] Timer tick, asking Buildbucket for the build status
[11:17:18.176] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:17:18.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:30:0) after 1m0s
[11:18:18.300] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:30:0)
[11:18:18.300] Timer tick, asking Buildbucket for the build status
[11:18:18.367] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:18:18.367] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:31:0) after 1m0s
[11:19:18.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:31:0)
[11:19:18.558] Timer tick, asking Buildbucket for the build status
[11:19:18.614] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:19:18.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:32:0) after 1m0s
[11:20:18.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:32:0)
[11:20:18.791] Timer tick, asking Buildbucket for the build status
[11:20:19.228] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:20:19.228] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:33:0) after 1m0s
[11:21:19.312] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:33:0)
[11:21:19.312] Timer tick, asking Buildbucket for the build status
[11:21:19.381] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:21:19.381] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:34:0) after 1m0s
[11:22:19.429] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:34:0)
[11:22:19.429] Timer tick, asking Buildbucket for the build status
[11:22:19.525] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:22:19.525] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:35:0) after 1m0s
[11:23:19.657] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:35:0)
[11:23:19.657] Timer tick, asking Buildbucket for the build status
[11:23:19.724] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:23:19.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:36:0) after 1m0s
[11:24:19.802] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:36:0)
[11:24:19.802] Timer tick, asking Buildbucket for the build status
[11:24:19.873] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:24:19.873] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:37:0) after 1m0s
[11:25:19.929] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:37:0)
[11:25:19.929] Timer tick, asking Buildbucket for the build status
[11:25:20.163] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:25:20.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:38:0) after 1m0s
[11:26:20.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:38:0)
[11:26:20.215] Timer tick, asking Buildbucket for the build status
[11:26:21.917] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:26:21.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:39:0) after 1m0s
[11:27:21.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:39:0)
[11:27:21.993] Timer tick, asking Buildbucket for the build status
[11:27:22.075] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:27:22.075] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:40:0) after 1m0s
[11:28:22.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:40:0)
[11:28:22.121] Timer tick, asking Buildbucket for the build status
[11:28:22.192] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:28:22.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:41:0) after 1m0s
[11:29:22.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:41:0)
[11:29:22.243] Timer tick, asking Buildbucket for the build status
[11:29:22.337] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:29:22.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:42:0) after 1m0s
[11:30:22.419] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:42:0)
[11:30:22.419] Timer tick, asking Buildbucket for the build status
[11:30:22.591] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:30:22.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:43:0) after 1m0s
[11:31:22.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:43:0)
[11:31:22.632] Timer tick, asking Buildbucket for the build status
[11:31:22.780] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:31:22.780] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:44:0) after 1m0s
[11:32:22.861] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:44:0)
[11:32:22.861] Timer tick, asking Buildbucket for the build status
[11:32:22.927] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:32:22.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:45:0) after 1m0s
[11:33:22.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:45:0)
[11:33:22.975] Timer tick, asking Buildbucket for the build status
[11:33:23.065] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:33:23.065] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:46:0) after 1m0s
[11:34:23.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:46:0)
[11:34:23.037] Timer tick, asking Buildbucket for the build status
[11:34:23.099] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:34:23.099] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:47:0) after 1m0s
[11:35:23.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:47:0)
[11:35:23.217] Timer tick, asking Buildbucket for the build status
[11:35:23.406] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:35:23.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:48:0) after 1m0s
[11:36:23.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:48:0)
[11:36:23.515] Timer tick, asking Buildbucket for the build status
[11:36:23.575] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:36:23.575] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:49:0) after 1m0s
[11:37:23.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:49:0)
[11:37:23.654] Timer tick, asking Buildbucket for the build status
[11:37:23.717] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:37:23.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:50:0) after 1m0s
[11:38:23.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:50:0)
[11:38:23.824] Timer tick, asking Buildbucket for the build status
[11:38:23.905] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:38:23.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:51:0) after 1m0s
[11:39:23.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:51:0)
[11:39:23.924] Timer tick, asking Buildbucket for the build status
[11:39:23.984] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:39:23.984] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:52:0) after 1m0s
[11:40:24.019] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:52:0)
[11:40:24.019] Timer tick, asking Buildbucket for the build status
[11:40:24.129] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:40:24.129] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:53:0) after 1m0s
[11:41:24.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:53:0)
[11:41:24.154] Timer tick, asking Buildbucket for the build status
[11:41:24.234] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:41:24.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:54:0) after 1m0s
[11:42:24.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:54:0)
[11:42:24.301] Timer tick, asking Buildbucket for the build status
[11:42:24.370] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:42:24.370] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:55:0) after 1m0s
[11:43:24.504] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:55:0)
[11:43:24.504] Timer tick, asking Buildbucket for the build status
[11:43:24.692] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:43:24.692] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:56:0) after 1m0s
[11:44:24.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:56:0)
[11:44:24.897] Timer tick, asking Buildbucket for the build status
[11:44:25.007] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:44:25.007] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:57:0) after 1m0s
[11:45:25.153] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:57:0)
[11:45:25.153] Timer tick, asking Buildbucket for the build status
[11:45:25.375] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:45:25.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:58:0) after 1m0s
[11:46:25.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:58:0)
[11:46:25.448] Timer tick, asking Buildbucket for the build status
[11:46:25.895] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:46:25.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:59:0) after 1m0s
[11:47:25.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:59:0)
[11:47:25.953] Timer tick, asking Buildbucket for the build status
[11:47:26.055] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:47:26.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:60:0) after 1m0s
[11:48:26.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:60:0)
[11:48:26.082] Timer tick, asking Buildbucket for the build status
[11:48:26.152] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:48:26.152] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:61:0) after 1m0s
[11:49:26.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:61:0)
[11:49:26.158] Timer tick, asking Buildbucket for the build status
[11:49:26.572] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:49:26.572] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:62:0) after 1m0s
[11:50:26.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:62:0)
[11:50:26.611] Timer tick, asking Buildbucket for the build status
[11:50:26.765] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:50:26.765] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:63:0) after 1m0s
[11:51:27.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:63:0)
[11:51:27.186] Timer tick, asking Buildbucket for the build status
[11:51:27.272] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:51:27.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:64:0) after 1m0s
[11:52:27.464] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:64:0)
[11:52:27.464] Timer tick, asking Buildbucket for the build status
[11:52:27.586] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:52:27.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:65:0) after 1m0s
[11:53:27.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:65:0)
[11:53:27.644] Timer tick, asking Buildbucket for the build status
[11:53:28.227] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:53:28.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:66:0) after 1m0s
[11:54:28.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:66:0)
[11:54:28.317] Timer tick, asking Buildbucket for the build status
[11:54:28.616] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:54:28.616] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:67:0) after 1m0s
[11:55:28.651] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:67:0)
[11:55:28.651] Timer tick, asking Buildbucket for the build status
[11:55:29.772] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:55:29.772] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:68:0) after 1m0s
[11:56:29.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:68:0)
[11:56:29.924] Timer tick, asking Buildbucket for the build status
[11:56:30.051] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:56:30.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:69:0) after 1m0s
[11:57:30.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:69:0)
[11:57:30.130] Timer tick, asking Buildbucket for the build status
[11:57:30.255] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:57:30.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:70:0) after 1m0s
[11:58:30.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:70:0)
[11:58:30.346] Timer tick, asking Buildbucket for the build status
[11:58:30.558] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:71:0) after 1m0s
[11:59:30.863] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:71:0)
[11:59:30.863] Timer tick, asking Buildbucket for the build status
[11:59:30.975] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:30.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:72:0) after 1m0s
[12:00:31.211] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:72:0)
[12:00:31.211] Timer tick, asking Buildbucket for the build status
[12:00:31.354] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:73:0) after 1m0s
[12:01:31.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:73:0)
[12:01:31.397] Timer tick, asking Buildbucket for the build status
[12:01:31.731] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:31.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:74:0) after 1m0s
[12:02:32.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:74:0)
[12:02:32.005] Timer tick, asking Buildbucket for the build status
[12:02:32.384] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.384] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:75:0) after 1m0s
[12:03:32.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:75:0)
[12:03:32.502] Timer tick, asking Buildbucket for the build status
[12:03:32.636] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:32.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:76:0) after 1m0s
[12:04:32.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:76:0)
[12:04:32.784] Timer tick, asking Buildbucket for the build status
[12:04:32.852] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:32.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:77:0) after 1m0s
[12:05:32.957] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:77:0)
[12:05:32.957] Timer tick, asking Buildbucket for the build status
[12:05:33.557] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:33.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:78:0) after 1m0s
[12:06:33.671] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:78:0)
[12:06:33.671] Timer tick, asking Buildbucket for the build status
[12:06:33.737] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:33.737] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:79:0) after 1m0s
[12:07:33.865] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:79:0)
[12:07:33.865] Timer tick, asking Buildbucket for the build status
[12:07:33.944] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:33.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:80:0) after 1m0s
[12:08:34.021] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:80:0)
[12:08:34.021] Timer tick, asking Buildbucket for the build status
[12:08:34.168] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:34.168] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:81:0) after 1m0s
[12:09:34.275] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:81:0)
[12:09:34.275] Timer tick, asking Buildbucket for the build status
[12:09:34.339] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:34.339] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:82:0) after 1m0s
[12:10:34.379] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:82:0)
[12:10:34.379] Timer tick, asking Buildbucket for the build status
[12:10:34.543] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:34.543] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:83:0) after 1m0s
[12:11:34.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:83:0)
[12:11:34.699] Timer tick, asking Buildbucket for the build status
[12:11:34.903] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:84:0) after 1m0s
[12:12:34.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:84:0)
[12:12:34.932] Timer tick, asking Buildbucket for the build status
[12:12:35.186] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:35.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:85:0) after 1m0s
[12:13:35.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:85:0)
[12:13:35.276] Timer tick, asking Buildbucket for the build status
[12:13:35.435] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:35.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:86:0) after 1m0s
[12:14:35.495] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:86:0)
[12:14:35.495] Timer tick, asking Buildbucket for the build status
[12:14:35.573] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:35.573] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:87:0) after 1m0s
[12:15:35.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:87:0)
[12:15:35.603] Timer tick, asking Buildbucket for the build status
[12:15:35.741] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:35.741] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:88:0) after 1m0s
[12:16:35.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:88:0)
[12:16:35.772] Timer tick, asking Buildbucket for the build status
[12:16:36.103] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:36.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:89:0) after 1m0s
[12:17:36.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:89:0)
[12:17:36.167] Timer tick, asking Buildbucket for the build status
[12:17:36.304] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:36.304] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:90:0) after 1m0s
[12:18:36.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:90:0)
[12:18:36.311] Timer tick, asking Buildbucket for the build status
[12:18:36.401] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:36.401] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:91:0) after 1m0s
[12:19:36.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:91:0)
[12:19:36.427] Timer tick, asking Buildbucket for the build status
[12:19:36.491] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:36.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:92:0) after 1m0s
[12:20:36.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:92:0)
[12:20:36.528] Timer tick, asking Buildbucket for the build status
[12:20:36.632] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:93:0) after 1m0s
[12:21:36.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:93:0)
[12:21:36.690] Timer tick, asking Buildbucket for the build status
[12:21:36.788] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:36.788] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:94:0) after 1m0s
[12:22:36.859] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:94:0)
[12:22:36.859] Timer tick, asking Buildbucket for the build status
[12:22:36.948] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:36.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:95:0) after 1m0s
[12:23:36.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:95:0)
[12:23:36.947] Timer tick, asking Buildbucket for the build status
[12:23:37.083] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:37.083] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:96:0) after 1m0s
[12:24:37.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:96:0)
[12:24:37.148] Timer tick, asking Buildbucket for the build status
[12:24:37.210] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:37.210] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:97:0) after 1m0s
[12:25:37.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:97:0)
[12:25:37.282] Timer tick, asking Buildbucket for the build status
[12:25:37.548] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:37.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:98:0) after 1m0s
[12:26:37.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:98:0)
[12:26:37.632] Timer tick, asking Buildbucket for the build status
[12:26:37.907] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:37.907] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:99:0) after 1m0s
[12:27:37.935] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:99:0)
[12:27:37.935] Timer tick, asking Buildbucket for the build status
[12:27:38.302] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:38.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:100:0) after 1m0s
[12:28:38.339] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:100:0)
[12:28:38.340] Timer tick, asking Buildbucket for the build status
[12:28:38.415] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:38.415] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:101:0) after 1m0s
[12:29:38.466] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:101:0)
[12:29:38.466] Timer tick, asking Buildbucket for the build status
[12:29:38.994] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:38.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:102:0) after 1m0s
[12:30:39.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:102:0)
[12:30:39.034] Timer tick, asking Buildbucket for the build status
[12:30:39.209] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:39.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:103:0) after 1m0s
[12:31:39.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:103:0)
[12:31:39.311] Timer tick, asking Buildbucket for the build status
[12:31:39.400] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:39.400] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:104:0) after 1m0s
[12:32:39.440] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:104:0)
[12:32:39.440] Timer tick, asking Buildbucket for the build status
[12:32:39.551] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:39.551] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:105:0) after 1m0s
[12:33:39.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:105:0)
[12:33:39.552] Timer tick, asking Buildbucket for the build status
[12:33:40.110] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:40.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:106:0) after 1m0s
[12:34:40.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:106:0)
[12:34:40.229] Timer tick, asking Buildbucket for the build status
[12:34:40.350] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:40.350] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:107:0) after 1m0s
[12:35:40.375] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:107:0)
[12:35:40.375] Timer tick, asking Buildbucket for the build status
[12:35:40.512] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:40.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:108:0) after 1m0s
[12:36:40.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:108:0)
[12:36:40.536] Timer tick, asking Buildbucket for the build status
[12:36:40.839] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:40.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:109:0) after 1m0s
[12:37:40.867] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:109:0)
[12:37:40.867] Timer tick, asking Buildbucket for the build status
[12:37:40.937] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:40.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:110:0) after 1m0s
[12:38:41.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:110:0)
[12:38:41.005] Timer tick, asking Buildbucket for the build status
[12:38:41.226] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:41.226] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:111:0) after 1m0s
[12:39:41.226] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:111:0)
[12:39:41.226] Timer tick, asking Buildbucket for the build status
[12:39:41.513] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:41.513] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:112:0) after 1m0s
[12:40:41.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:112:0)
[12:40:41.543] Timer tick, asking Buildbucket for the build status
[12:40:41.653] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:41.653] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:113:0) after 1m0s
[12:41:41.681] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:113:0)
[12:41:41.681] Timer tick, asking Buildbucket for the build status
[12:41:41.808] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:41.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:114:0) after 1m0s
[12:42:41.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:114:0)
[12:42:41.833] Timer tick, asking Buildbucket for the build status
[12:42:41.953] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:41.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:115:0) after 1m0s
[12:43:41.987] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:115:0)
[12:43:41.988] Timer tick, asking Buildbucket for the build status
[12:43:42.685] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:42.685] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:116:0) after 1m0s
[12:44:42.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:116:0)
[12:44:42.672] Timer tick, asking Buildbucket for the build status
[12:44:42.855] Build 8865654310019520784: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:42.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031084372427468112:117:0) after 1m0s
[12:45:18.734] Received PubSub notification, asking Buildbucket for the build status
[12:45:18.999] Build 8865654310019520784: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[12:45:19.000] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603457117314975",
"created_by": "project:chromium",
"created_ts": "1603450208606994",
"id": "8865654310019520784",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\"}}",
"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\": \"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\", \"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-64-2oix\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20977, \"got_angle_revision\": \"5641e3c185a85c04f40441698d693773b1e9e808\", \"got_dawn_revision\": \"ade9a5235c73656699662ec9371a9d42fea34ac6\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\", \"got_revision_cp\": \"refs/heads/master@{#820192}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"871500da90418cc3e80e8a0eef257ce11abadd27\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32475}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8fad5216b9d7045dbab8b5c22bd2029b57a8438e\", \"swarm_hashes_refs/heads/master(at){#820192}_without_patch\": {\"absl_hardening_tests\": \"f66b1ef68f129fc632878f79227a983d086c0e39\", \"accessibility_unittests\": \"fbef180d9f336d6b6362115d5c2bd8f5e4a555a4\", \"app_list_unittests\": \"123be402a207ca428ebf115199c5fc2de496e8ae\", \"app_shell_unittests\": \"c958f138e0d0ea1ec471fdaca756ef47de39352b\", \"ash_unittests\": \"30ae9b9637fda9ed008755683c88313f21f350fe\", \"aura_unittests\": \"b1169a347517845e60af62271659e16bc422d4e7\", \"base_unittests\": \"81bdb81127430270943ef60774bb3bdd1d64e5b2\", \"base_util_unittests\": \"743f443156f03aad63d784d91807948955201165\", \"blink_common_unittests\": \"a4a664d429f1a0afb1d222c2f248451b24bcdb64\", \"blink_fuzzer_unittests\": \"73399551cec683de7e01e9b851d25f2cca1d4e22\", \"blink_heap_unittests\": \"2aeeec826cf59e08d38753fde2df55b1b5777c22\", \"blink_platform_unittests\": \"2312f2201e4a29c099f53d7775e674b6279eeba9\", \"blink_unittests\": \"aec146c3870f8b68d31a2834d1b3b36626fd1b98\", \"boringssl_crypto_tests\": \"0a54058dfc8efc251c619ace327fec14713e7f7e\", \"boringssl_ssl_tests\": \"4920012c2cfbed540563e32d6ec033d8ce520e2e\", \"browser_tests\": \"6100a0ef64405d12bfbd23f8f91a27f9219e7cc7\", \"capture_unittests\": \"c35685ce39ce76e4bbb1d2f637af857939ca396c\", \"cast_unittests\": \"d485c3657c3b84e9c4ce98c73eb98c73ca3c3dd2\", \"cc_unittests\": \"b35679e04df7a66ce5a0cd78704a34f59ed754cd\", \"chrome_app_unittests\": \"483b804899329d7c438fce0b9925abb207078bb9\", \"chromedriver_unittests\": \"a1f5a82455f26bc9286749a2ad21f13b08dabe81\", \"chromeos_components_unittests\": \"2b829df31560ef02d533e162e2d55eb6c068168d\", \"chromeos_unittests\": \"6ace1ec26fd9265ad4c0fc12fedfb7f1218a6816\", \"components_browsertests\": \"b2ccb8c23df7d6d13f94611b57e4a7f51c8bdfb2\", \"components_unittests\": \"3e8938117b8815722a9461c4e4066ffda142392a\", \"compositor_unittests\": \"f88cf5a212344ed4547f0f60921e51b2c353d498\", \"content_browsertests\": \"105b41a971b996c319b7d80dfd9239f0e44342ad\", \"content_unittests\": \"21a607192ca321b35a290b98788d3b05b768ecba\", \"crypto_unittests\": \"592e77ee007b22ee0c2414a7f6ea3354b43fa121\", \"dbus_unittests\": \"1febe7b687af4b46b2ccd768486cc4c78cc54e92\", \"device_unittests\": \"01a5971dc04fabaaa743f222e8168b55f282c2bb\", \"display_unittests\": \"9dec5cca7d9edc795c4c649a96af2b318722babf\", \"events_unittests\": \"444cc37f5e0b3170727f5ef4f359db7b12d1d0de\", \"exo_unittests\": \"4ff8c5d81191748b5504c7dbfa3893b10788d4d6\", \"extensions_browsertests\": \"dae6c6229a7b43d00371bb34569359fa620c1dd8\", \"extensions_unittests\": \"3788a8314e8e9b22a6610e1f2368afaa1ae79b96\", \"filesystem_service_unittests\": \"dc5e552b83153cd72c9537b63d4eb9c7e186f3b4\", \"gcm_unit_tests\": \"89c4d12e532aec65d320281e67d03f274a2e66ca\", \"gfx_unittests\": \"8ca9327903082c46749d6e952f53f18017538d3f\", \"gin_unittests\": \"a0509878273100aa27b6ce93d9652b942da37dc2\", \"gl_unittests_ozone\": \"fa5f167d74b88986fa440d0d83ae752dad954e82\", \"google_apis_unittests\": \"7b9f544babc21ae6d42d24ae21b0ca32d8c7b223\", \"gpu_unittests\": \"9936f2bdd1ac3eb6bdfb6900c8107c6c4627e70b\", \"gwp_asan_unittests\": \"573d3cd554a41a36152a33cf5211b316a264c2de\", \"interactive_ui_tests\": \"de90b70a531c21faa0257fdfff7788eee9163d34\", \"ipc_tests\": \"01c42d1cb79ef7a7f03418dce92c06c41e16b382\", \"jingle_unittests\": \"1a30ff1f488299c4c8d0a88a44c68105b42191e1\", \"keyboard_unittests\": \"31790339e9fc52037e62991b066b98aebfdf85f6\", \"latency_unittests\": \"9cd0aa64d20dcd0da389f057dd4f604ae5699ea5\", \"libjingle_xmpp_unittests\": \"56b7f7def6157287d0d7629017d238f7107ad4e3\", \"media_blink_unittests\": \"f1fd6743b49fcfb200fc6e231a6bdf24d67059d5\", \"media_unittests\": \"2b03755903673ae37b1ab3d1a180f1eee21ab157\", \"message_center_unittests\": \"a4c786fd92134812011eb001a4a508ce456153e4\", \"midi_unittests\": \"b6457c8b10e3005abe53bf64f0f4faf87f2b4c7d\", \"mojo_core_unittests\": \"ea946abd49798515b4a34d37fed29217b7228136\", \"mojo_unittests\": \"1363119d3bdabc9bee7c8e81a590773840590f0c\", \"nacl_helper_nonsfi_unittests\": \"56d8af40a5b86171f81a2168245e80441f2116e8\", \"nacl_loader_unittests\": \"bd043fd2ab0c49e5dbc71b46a973dc220a96cce0\", \"native_theme_unittests\": \"e5d4c17938ea4a527da1ffa71978422bc75ced34\", \"net_unittests\": \"8b75d302b87da461b267d30ff4cec60b504b5c86\", \"ozone_gl_unittests\": \"6cad3241a2a6690a6be6a9448dc93bfeaf7f7184\", \"ozone_unittests\": \"fbbf6341a38a84bb3af38624b84bfa78e61b9b6d\", \"ozone_x11_unittests\": \"3b511e79b749fa9f9fb44edd5584797e71c26b79\", \"pdf_unittests\": \"f695b2dafd57c10fdf808997823ee464e2c613f9\", \"perfetto_unittests\": \"e0d1253ce667db07ce9e38cf1d2bf14355eb87d1\", \"ppapi_unittests\": \"59405b89a6d082b88c597ca9a54e69251a20d136\", \"printing_unittests\": \"7b4599c5bf4fe6d21ac0b97a0a998c8cb63618a3\", \"remoting_unittests\": \"147306be37b6b7185a266eae517f705b62fd04be\", \"sandbox_linux_unittests\": \"375fd736a1f277ac62ecd2354d4fcecf2f366f51\", \"service_manager_unittests\": \"be26528fcebd328e104cc58ebb00d558a2a83222\", \"services_unittests\": \"193cff88ebd3f5f9647375dab43e041a0d6e1e5f\", \"shell_dialogs_unittests\": \"634179cf6a10503f49f68b0e657f96e94281ad87\", \"skia_unittests\": \"fc0426d447433ef25e347c5a60c0a19c3a1962af\", \"snapshot_unittests\": \"5ef3fde077834243b2ce0321b0228597774b18b4\", \"sql_unittests\": \"4ed991040cb8331f141eacd4937e43aa6ab54b04\", \"standalone_angle_unittests\": \"5a7de1424068b5971721e0760c3c549778e651f8\", \"storage_unittests\": \"bdcc397419e7eeca16d565a8ac25b4d63d106aa4\", \"sync_integration_tests\": \"72cb83082bcfbbf180e103d2c958550e6df5128e\", \"traffic_annotation_auditor_unittests\": \"c2adfb7aaa6ba323923fdeca1344e9f697c47c88\", \"ui_base_unittests\": \"64d902dc1192666908c065f896cb96905845130f\", \"ui_chromeos_unittests\": \"80339ced3413dbc3261ee6273f85e06904c93fdf\", \"ui_touch_selection_unittests\": \"fb9826ae693d2945f7d2ceda0a35eb27db43fc37\", \"unit_tests\": \"45d9f2e4e62371ed6aa3ce134fb0cd151be9f13d\", \"url_unittests\": \"eed219cad8e5db97b5fbc2e49d65475750ab20b1\", \"usage_time_limit_unittests\": \"9eb7e5d5955a569b46c7af92f666388b51aa6f6a\", \"views_unittests\": \"355514e6ffe7aeac0702e9457fd16e6682abd2e2\", \"viz_unittests\": \"94ad9fbd15c983446e6fd6fa2e7e9a1f2f693aa6\", \"wm_unittests\": \"3d1707fbb65e419518375748f347b8a0516ec0aa\", \"wtf_unittests\": \"f06e5b21f142b3e3f55b878566a72f09c354fceb\", \"zlib_unittests\": \"d7a6b24614a1beaf32f5f9995806169a5eb6cf44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3f81ed4451c975c2dad8aeab96873eead95b88de9f86596d05edcfd1a5ff7d01_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-64-2oix\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603450502836314",
"status": "COMPLETED",
"status_changed_ts": "1603457117683518",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20977",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8fad5216b9d7045dbab8b5c22bd2029b57a8438e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031084372427468112",
"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/8865654310019520784/+/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:4f6de60f8c0edc10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603457117707387",
"url": "https://ci.chromium.org/b/8865654310019520784",
"utcnow_ts": "1603457118979711"
}
}
[12:45:19.000] Invocation finished in 1h55m12.073842162s with status SUCCEEDED